builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0177 starttime: 1458941677.87 results: success (0) buildid: 20160325134240 builduid: 7029fa17c51e4531b4992c848e396e04 revision: 28a35458f825099bb18ea5af6dd92d85c660f7b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 14:34:37.872995) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 14:34:37.873409) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2016-03-25 14:34:37.873707) ========= 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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.005993 basedir: '/builds/slave/test' ========= master_lag: 1.75 ========= ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2016-03-25 14:34:39.630983) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 14:34:39.631265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 14:34:39.661725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 14:34:39.662991) ========= 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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.005566 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 14:34:39.711045) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 14:34:39.711332) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 14:34:39.715096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 14:34:39.715389) ========= 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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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-25 14:34:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.2M=0s 2016-03-25 14:34:39 (24.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173578 ========= master_lag: 0.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 14:34:40.145747) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 14:34:40.146134) ========= 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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.020489 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 14:34:40.190370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-25 14:34:40.190690) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 28a35458f825099bb18ea5af6dd92d85c660f7b9 --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 28a35458f825099bb18ea5af6dd92d85c660f7b9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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-25 14:34:40,275 truncating revision to first 12 chars 2016-03-25 14:34:40,275 Setting DEBUG logging. 2016-03-25 14:34:40,275 attempt 1/10 2016-03-25 14:34:40,275 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/28a35458f825?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 14:34:41,645 unpacking tar archive at: fx-team-28a35458f825/testing/mozharness/ program finished with exit code 0 elapsedTime=1.617471 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-25 14:34:41.831668) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-25 14:34:41.832004) ========= echo 28a35458f825099bb18ea5af6dd92d85c660f7b9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'28a35458f825099bb18ea5af6dd92d85c660f7b9'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 28a35458f825099bb18ea5af6dd92d85c660f7b9 program finished with exit code 0 elapsedTime=0.005238 script_repo_revision: '28a35458f825099bb18ea5af6dd92d85c660f7b9' ========= master_lag: 1.55 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-25 14:34:43.382365) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-03-25 14:34:43.382710) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-03-25 14:34:49.083598) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-03-25 14:34:49.083892) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 14:34:49 INFO - MultiFileLogger online at 20160325 14:34:49 in /builds/slave/test 14:34:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:34:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:34:49 INFO - {'append_to_log': False, 14:34:49 INFO - 'base_work_dir': '/builds/slave/test', 14:34:49 INFO - 'blob_upload_branch': 'Fx-Team', 14:34:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:34:49 INFO - 'branch': 'Fx-Team', 14:34:49 INFO - 'buildbot_json_path': 'buildprops.json', 14:34:49 INFO - 'config_files': ('talos/mac_config.py',), 14:34:49 INFO - 'default_actions': ('clobber', 14:34:49 INFO - 'read-buildbot-config', 14:34:49 INFO - 'download-and-extract', 14:34:49 INFO - 'populate-webroot', 14:34:49 INFO - 'create-virtualenv', 14:34:49 INFO - 'install', 14:34:49 INFO - 'run-tests'), 14:34:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:34:49 INFO - 'download_minidump_stackwalk': True, 14:34:49 INFO - 'download_symbols': 'ondemand', 14:34:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:34:49 INFO - 'tooltool.py': '/tools/tooltool.py', 14:34:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:34:49 INFO - '/tools/misc-python/virtualenv.py')}, 14:34:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:34:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:34:49 INFO - 'installer_path': 'installer.exe', 14:34:49 INFO - 'log_level': 'info', 14:34:49 INFO - 'log_name': 'talos', 14:34:49 INFO - 'log_to_console': True, 14:34:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:34:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:34:49 INFO - 'opt_config_files': (), 14:34:49 INFO - 'pip_index': False, 14:34:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:34:49 INFO - 'cmd': ('bash', 14:34:49 INFO - '-c', 14:34:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:34:49 INFO - 'enabled': True, 14:34:49 INFO - 'halt_on_failure': False, 14:34:49 INFO - 'name': 'check_screen_resolution'},), 14:34:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:34:49 INFO - 'cmd': ('bash', 14:34:49 INFO - '-c', 14:34:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:34:49 INFO - 'enabled': True, 14:34:49 INFO - 'halt_on_failure': False, 14:34:49 INFO - 'name': 'check_screen_resolution'},), 14:34:49 INFO - 'run_cmd_checks_enabled': True, 14:34:49 INFO - 'sps_profile': False, 14:34:49 INFO - 'sps_profile_interval': 0, 14:34:49 INFO - 'suite': 'dromaeojs', 14:34:49 INFO - 'system_bits': '32', 14:34:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:34:49 INFO - 'title': 't-yosemite-r7-0177', 14:34:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:34:49 INFO - 'use_talos_json': True, 14:34:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:34:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:34:49 INFO - 'work_dir': 'build'} 14:34:49 INFO - ##### 14:34:49 INFO - ##### Running clobber step. 14:34:49 INFO - ##### 14:34:49 INFO - Running pre-action listener: _resource_record_pre_action 14:34:49 INFO - Running main action method: clobber 14:34:49 INFO - rmtree: /builds/slave/test/build 14:34:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:34:50 INFO - Running post-action listener: _resource_record_post_action 14:34:50 INFO - ##### 14:34:50 INFO - ##### Running read-buildbot-config step. 14:34:50 INFO - ##### 14:34:50 INFO - Running pre-action listener: _resource_record_pre_action 14:34:50 INFO - Running main action method: read_buildbot_config 14:34:50 INFO - Using buildbot properties: 14:34:50 INFO - { 14:34:50 INFO - "project": "", 14:34:50 INFO - "product": "firefox", 14:34:50 INFO - "script_repo_revision": "production", 14:34:50 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:34:50 INFO - "repository": "", 14:34:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:34:50 INFO - "buildid": "20160325134240", 14:34:50 INFO - "pgo_build": "False", 14:34:50 INFO - "basedir": "/builds/slave/test", 14:34:50 INFO - "buildnumber": 628, 14:34:50 INFO - "slavename": "t-yosemite-r7-0177", 14:34:50 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:34:50 INFO - "platform": "yosemite_r7", 14:34:50 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:34:50 INFO - "branch": "fx-team", 14:34:50 INFO - "repo_path": "integration/fx-team", 14:34:50 INFO - "revision": "28a35458f825099bb18ea5af6dd92d85c660f7b9", 14:34:50 INFO - "stage_platform": "macosx64", 14:34:50 INFO - "builduid": "7029fa17c51e4531b4992c848e396e04", 14:34:50 INFO - "slavebuilddir": "test" 14:34:50 INFO - } 14:34:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 14:34:50 INFO - Running post-action listener: _resource_record_post_action 14:34:50 INFO - ##### 14:34:50 INFO - ##### Running download-and-extract step. 14:34:50 INFO - ##### 14:34:50 INFO - Running pre-action listener: _resource_record_pre_action 14:34:50 INFO - Running main action method: download_and_extract 14:34:50 INFO - mkdir: /builds/slave/test/build/tests 14:34:50 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')]} 14:34:50 INFO - https://queue.taskcluster.net/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:34:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:34:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:34:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/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 14:34:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/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 14:34:51 INFO - Downloaded 1199 bytes. 14:34:51 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:34:51 INFO - Using the following test package requirements: 14:34:51 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:34:51 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:51 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 14:34:51 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:51 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 14:34:51 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:51 INFO - u'jsshell-mac.zip'], 14:34:51 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:51 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 14:34:51 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:34:51 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:51 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 14:34:51 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:51 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 14:34:51 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:51 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 14:34:51 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:51 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 14:34:51 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:51 INFO - https://queue.taskcluster.net/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:34:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:34:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:34:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/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 14:34:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/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 14:34:52 INFO - Downloaded 17943729 bytes. 14:34:52 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'] 14:34:52 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 14:34:55 INFO - Return code: 0 14:34:55 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 14:34:55 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')]} 14:34:55 INFO - https://queue.taskcluster.net/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:34:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:34:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:34:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/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 14:34:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/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 14:34:57 INFO - Downloaded 17943729 bytes. 14:34:57 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'] 14:34:57 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 14:35:00 INFO - Return code: 0 14:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:00 INFO - https://queue.taskcluster.net/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:35:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:35:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:35:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/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 14:35:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/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 14:35:01 INFO - Downloaded 10847531 bytes. 14:35:01 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'] 14:35:01 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 14:35:01 INFO - Return code: 0 14:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:01 INFO - https://queue.taskcluster.net/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:35:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:35:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:35:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 14:35:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/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 14:35:04 INFO - Downloaded 111383542 bytes. 14:35:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:35:04 INFO - mkdir: /builds/slave/test/properties 14:35:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:35:04 INFO - Writing to file /builds/slave/test/properties/build_url 14:35:04 INFO - Contents: 14:35:04 INFO - build_url:https://queue.taskcluster.net/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:35:06 INFO - Running post-action listener: _resource_record_post_action 14:35:06 INFO - Running post-action listener: set_extra_try_arguments 14:35:06 INFO - ##### 14:35:06 INFO - ##### Running populate-webroot step. 14:35:06 INFO - ##### 14:35:06 INFO - Running pre-action listener: _resource_record_pre_action 14:35:06 INFO - Running main action method: populate_webroot 14:35:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:35:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:35:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:35:06 INFO - '--tppagecycles', 14:35:06 INFO - '7'], 14:35:06 INFO - 'tests': ['tsvgm']}}, 14:35:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:35:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:35:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:35:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:35:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:35:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:35:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:35:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:06 INFO - 'talos_options': ['--e10s'], 14:35:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:35:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:06 INFO - 'tests': ['damp', 'tps']}, 14:35:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:06 INFO - 'talos_options': ['--e10s'], 14:35:06 INFO - 'tests': ['damp', 'tps']}, 14:35:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:35:06 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 14:35:06 INFO - 'tests': ['dromaeo_dom']}, 14:35:06 INFO - 'other': {'tests': ['a11yr', 14:35:06 INFO - 'ts_paint', 14:35:06 INFO - 'tpaint', 14:35:06 INFO - 'sessionrestore', 14:35:06 INFO - 'sessionrestore_no_auto_restore', 14:35:06 INFO - 'tabpaint']}, 14:35:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:35:06 INFO - 'tests': ['a11yr', 14:35:06 INFO - 'ts_paint', 14:35:06 INFO - 'tpaint', 14:35:06 INFO - 'sessionrestore', 14:35:06 INFO - 'sessionrestore_no_auto_restore', 14:35:06 INFO - 'tabpaint']}, 14:35:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:35:06 INFO - 'tests': ['a11yr', 14:35:06 INFO - 'ts_paint', 14:35:06 INFO - 'tpaint', 14:35:06 INFO - 'sessionrestore', 14:35:06 INFO - 'sessionrestore_no_auto_restore', 14:35:06 INFO - 'tabpaint']}, 14:35:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:35:06 INFO - 'tests': ['a11yr', 14:35:06 INFO - 'ts_paint', 14:35:06 INFO - 'tpaint', 14:35:06 INFO - 'sessionrestore', 14:35:06 INFO - 'sessionrestore_no_auto_restore', 14:35:06 INFO - 'tabpaint']}, 14:35:06 INFO - 'other_l64': {'tests': ['a11yr', 14:35:06 INFO - 'ts_paint', 14:35:06 INFO - 'tpaint', 14:35:06 INFO - 'sessionrestore', 14:35:06 INFO - 'sessionrestore_no_auto_restore', 14:35:06 INFO - 'tabpaint']}, 14:35:06 INFO - 'other_nol64': {'tests': ['a11yr', 14:35:06 INFO - 'ts_paint', 14:35:06 INFO - 'tpaint', 14:35:06 INFO - 'sessionrestore', 14:35:06 INFO - 'sessionrestore_no_auto_restore', 14:35:06 INFO - 'tabpaint']}, 14:35:06 INFO - 'svgr': {'tests': ['tsvgx', 14:35:06 INFO - 'tsvgr_opacity', 14:35:06 INFO - 'tart', 14:35:06 INFO - 'tscrollx', 14:35:06 INFO - 'cart']}, 14:35:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:35:06 INFO - 'tests': ['tsvgx', 14:35:06 INFO - 'tsvgr_opacity', 14:35:06 INFO - 'tart', 14:35:06 INFO - 'tscrollx', 14:35:06 INFO - 'cart']}, 14:35:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:06 INFO - 'tests': ['tp5o']}, 14:35:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:06 INFO - 'talos_options': ['--e10s'], 14:35:06 INFO - 'tests': ['tp5o']}, 14:35:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:06 INFO - 'talos_options': ['--xperf_path', 14:35:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:35:06 INFO - 'tests': ['tp5n']}, 14:35:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:06 INFO - 'talos_options': ['--e10s', 14:35:06 INFO - '--xperf_path', 14:35:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:35:06 INFO - 'tests': ['tp5n']}}, 14:35:06 INFO - 'talos.zip': {'path': '', 14:35:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:35:06 INFO - Running post-action listener: _resource_record_post_action 14:35:06 INFO - ##### 14:35:06 INFO - ##### Running create-virtualenv step. 14:35:06 INFO - ##### 14:35:06 INFO - Running pre-action listener: _resource_record_pre_action 14:35:06 INFO - Running main action method: create_virtualenv 14:35:06 INFO - Creating virtualenv /builds/slave/test/build/venv 14:35:06 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 14:35:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:35:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:35:06 INFO - Using real prefix '/tools/python27' 14:35:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:35:07 INFO - Installing distribute.............................................................................................................................................................................................done. 14:35:09 INFO - Installing pip.................done. 14:35:09 INFO - Return code: 0 14:35:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d74420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95094697a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c03e00>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bfeb20>, '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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 14:35:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:35:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bjwIXlBL3Q/Render', 14:35:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:09 INFO - 'HOME': '/Users/cltbld', 14:35:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:09 INFO - 'LOGNAME': 'cltbld', 14:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:09 INFO - 'MOZ_NO_REMOTE': '1', 14:35:09 INFO - 'NO_EM_RESTART': '1', 14:35:09 INFO - 'PAGER': '/bin/cat', 14:35:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:09 INFO - 'PWD': '/builds/slave/test', 14:35:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:09 INFO - 'SHELL': '/bin/bash', 14:35:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hPC4BGTfzz/Listeners', 14:35:09 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 14:35:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:09 INFO - 'USER': 'cltbld', 14:35:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:09 INFO - 'XPC_FLAGS': '0x0', 14:35:09 INFO - 'XPC_SERVICE_NAME': '0', 14:35:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:10 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 14:35:10 INFO - Cleaning up... 14:35:10 INFO - Return code: 0 14:35:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:10 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 0x109d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d74420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95094697a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c03e00>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bfeb20>, '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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 14:35:10 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 14:35:10 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 14:35:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bjwIXlBL3Q/Render', 14:35:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:10 INFO - 'HOME': '/Users/cltbld', 14:35:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:10 INFO - 'LOGNAME': 'cltbld', 14:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:10 INFO - 'MOZ_NO_REMOTE': '1', 14:35:10 INFO - 'NO_EM_RESTART': '1', 14:35:10 INFO - 'PAGER': '/bin/cat', 14:35:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:10 INFO - 'PWD': '/builds/slave/test', 14:35:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:10 INFO - 'SHELL': '/bin/bash', 14:35:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hPC4BGTfzz/Listeners', 14:35:10 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 14:35:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:10 INFO - 'USER': 'cltbld', 14:35:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:10 INFO - 'XPC_FLAGS': '0x0', 14:35:10 INFO - 'XPC_SERVICE_NAME': '0', 14:35:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:10 INFO - Downloading/unpacking psutil>=0.7.1 14:35:10 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 14:35:10 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 14:35:10 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 14:35:10 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 14:35:10 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 14:35:10 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 14:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:35:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:35:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:35:13 INFO - Installing collected packages: psutil 14:35:13 INFO - Running setup.py install for psutil 14:35:13 INFO - building 'psutil._psutil_osx' extension 14:35:13 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 14:35:13 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 14:35:13 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 14:35:14 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 14:35:14 INFO - building 'psutil._psutil_posix' extension 14:35:14 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 14:35:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:35:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:35:14 INFO - ^ 14:35:14 INFO - 1 warning generated. 14:35:14 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 14:35:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:35:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:35:14 INFO - Successfully installed psutil 14:35:14 INFO - Cleaning up... 14:35:14 INFO - Return code: 0 14:35:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:14 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 0x109d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d74420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95094697a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c03e00>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bfeb20>, '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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 14:35:14 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 14:35:14 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 14:35:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bjwIXlBL3Q/Render', 14:35:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:14 INFO - 'HOME': '/Users/cltbld', 14:35:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:14 INFO - 'LOGNAME': 'cltbld', 14:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:14 INFO - 'MOZ_NO_REMOTE': '1', 14:35:14 INFO - 'NO_EM_RESTART': '1', 14:35:14 INFO - 'PAGER': '/bin/cat', 14:35:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:14 INFO - 'PWD': '/builds/slave/test', 14:35:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:14 INFO - 'SHELL': '/bin/bash', 14:35:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hPC4BGTfzz/Listeners', 14:35:14 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 14:35:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:14 INFO - 'USER': 'cltbld', 14:35:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:14 INFO - 'XPC_FLAGS': '0x0', 14:35:14 INFO - 'XPC_SERVICE_NAME': '0', 14:35:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:35:14 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 14:35:14 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 14:35:14 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 14:35:14 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 14:35:14 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 14:35:14 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 14:35:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:35:17 INFO - Installing collected packages: mozsystemmonitor 14:35:17 INFO - Running setup.py install for mozsystemmonitor 14:35:17 INFO - Successfully installed mozsystemmonitor 14:35:17 INFO - Cleaning up... 14:35:17 INFO - Return code: 0 14:35:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:17 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 0x109d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d74420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95094697a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c03e00>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bfeb20>, '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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 14:35:17 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 14:35:17 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 14:35:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bjwIXlBL3Q/Render', 14:35:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:17 INFO - 'HOME': '/Users/cltbld', 14:35:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:17 INFO - 'LOGNAME': 'cltbld', 14:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:17 INFO - 'MOZ_NO_REMOTE': '1', 14:35:17 INFO - 'NO_EM_RESTART': '1', 14:35:17 INFO - 'PAGER': '/bin/cat', 14:35:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:17 INFO - 'PWD': '/builds/slave/test', 14:35:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:17 INFO - 'SHELL': '/bin/bash', 14:35:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hPC4BGTfzz/Listeners', 14:35:17 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 14:35:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:17 INFO - 'USER': 'cltbld', 14:35:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:17 INFO - 'XPC_FLAGS': '0x0', 14:35:17 INFO - 'XPC_SERVICE_NAME': '0', 14:35:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:17 INFO - Downloading/unpacking blobuploader==1.2.4 14:35:17 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 14:35:17 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 14:35:17 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 14:35:17 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 14:35:17 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 14:35:17 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 14:35:19 INFO - Downloading blobuploader-1.2.4.tar.gz 14:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:35:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:35:20 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 14:35:20 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 14:35:20 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 14:35:20 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 14:35:20 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 14:35:20 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 14:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:35:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:35:20 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 14:35:20 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 14:35:20 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 14:35:20 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 14:35:20 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 14:35:20 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 14:35:21 INFO - Downloading docopt-0.6.1.tar.gz 14:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:35:21 INFO - Installing collected packages: blobuploader, requests, docopt 14:35:21 INFO - Running setup.py install for blobuploader 14:35:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:35:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:35:21 INFO - Running setup.py install for requests 14:35:21 INFO - Running setup.py install for docopt 14:35:22 INFO - Successfully installed blobuploader requests docopt 14:35:22 INFO - Cleaning up... 14:35:22 INFO - Return code: 0 14:35:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:22 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 0x109d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d74420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95094697a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c03e00>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bfeb20>, '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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 14:35:22 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 14:35:22 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 14:35:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bjwIXlBL3Q/Render', 14:35:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:22 INFO - 'HOME': '/Users/cltbld', 14:35:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:22 INFO - 'LOGNAME': 'cltbld', 14:35:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:22 INFO - 'MOZ_NO_REMOTE': '1', 14:35:22 INFO - 'NO_EM_RESTART': '1', 14:35:22 INFO - 'PAGER': '/bin/cat', 14:35:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:22 INFO - 'PWD': '/builds/slave/test', 14:35:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:22 INFO - 'SHELL': '/bin/bash', 14:35:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hPC4BGTfzz/Listeners', 14:35:22 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 14:35:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:22 INFO - 'USER': 'cltbld', 14:35:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:22 INFO - 'XPC_FLAGS': '0x0', 14:35:22 INFO - 'XPC_SERVICE_NAME': '0', 14:35:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:35:22 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-whZrWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:35:22 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-IgNJZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:35:22 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-lbjOQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:35:23 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-agDGsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:35:23 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-wWin9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:35:23 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-bdxUPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:35:23 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-0uT6MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:35:23 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-12laXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:35:23 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-tofoQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:35:23 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-WSOpIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:35:23 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-8cHufT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:35:23 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-D6W8Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:35:23 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-IFZZhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:35:24 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-aGLc82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:24 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-7eTHEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:35:24 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-7AC9mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:35:24 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Pw170J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:35:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:35:24 INFO - Running setup.py install for manifestparser 14:35:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:35:24 INFO - Running setup.py install for mozcrash 14:35:24 INFO - Running setup.py install for mozdebug 14:35:24 INFO - Running setup.py install for mozdevice 14:35:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:35:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:35:25 INFO - Running setup.py install for mozfile 14:35:25 INFO - Running setup.py install for mozhttpd 14:35:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:35:25 INFO - Running setup.py install for mozinfo 14:35:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:35:25 INFO - Running setup.py install for mozInstall 14:35:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:35:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:35:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:35:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:35:25 INFO - Running setup.py install for mozleak 14:35:25 INFO - Running setup.py install for mozlog 14:35:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:35:26 INFO - Running setup.py install for moznetwork 14:35:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:35:26 INFO - Running setup.py install for mozprocess 14:35:26 INFO - Running setup.py install for mozprofile 14:35:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:35:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:35:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:35:26 INFO - Running setup.py install for mozrunner 14:35:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:35:26 INFO - Running setup.py install for mozscreenshot 14:35:26 INFO - Running setup.py install for moztest 14:35:26 INFO - Running setup.py install for mozversion 14:35:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:35:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:35:27 INFO - Cleaning up... 14:35:27 INFO - Return code: 0 14:35:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:27 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 0x109d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d74420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95094697a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c03e00>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bfeb20>, '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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 14:35:27 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 14:35:27 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 14:35:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bjwIXlBL3Q/Render', 14:35:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:27 INFO - 'HOME': '/Users/cltbld', 14:35:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:27 INFO - 'LOGNAME': 'cltbld', 14:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:27 INFO - 'MOZ_NO_REMOTE': '1', 14:35:27 INFO - 'NO_EM_RESTART': '1', 14:35:27 INFO - 'PAGER': '/bin/cat', 14:35:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:27 INFO - 'PWD': '/builds/slave/test', 14:35:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:27 INFO - 'SHELL': '/bin/bash', 14:35:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hPC4BGTfzz/Listeners', 14:35:27 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 14:35:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:27 INFO - 'USER': 'cltbld', 14:35:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:27 INFO - 'XPC_FLAGS': '0x0', 14:35:27 INFO - 'XPC_SERVICE_NAME': '0', 14:35:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:35:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-0wYAXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:35:27 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)) 14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:35:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-KHm0LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:35:27 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)) 14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:35:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-urJMFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:35:27 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)) 14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:35:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-G0oYwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:35:27 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)) 14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:35:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-akenrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:35:27 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)) 14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:35:27 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-HDawLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:35:28 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)) 14:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:35:28 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Ac24UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:35:28 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)) 14:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:35:28 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-txkuaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:35:28 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)) 14:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:35:28 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-0Gca1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:35:28 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)) 14:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:35:28 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-b7Olb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:35:28 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)) 14:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:35:28 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-GgmYse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:35:28 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)) 14:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:35:28 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-nD1Mck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:35:28 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)) 14:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:35:28 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Byrglg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:35:28 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)) 14:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:35:28 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-VufXKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:35:28 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)) 14:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:28 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Zoo0Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:28 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)) 14:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:35:29 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-7tk6k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:35:29 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)) 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:35:29 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-TV8Xqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:35:29 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)) 14:35:29 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)) 14:35:29 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)) 14:35:29 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)) 14:35:29 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)) 14:35:29 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)) 14:35:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35:31 INFO - Downloading blessings-1.6.tar.gz 14:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:35:32 INFO - Installing collected packages: blessings 14:35:32 INFO - Running setup.py install for blessings 14:35:32 INFO - Successfully installed blessings 14:35:32 INFO - Cleaning up... 14:35:32 INFO - Return code: 0 14:35:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:35:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:32 INFO - Reading from file tmpfile_stdout 14:35:32 INFO - Current package versions: 14:35:32 INFO - blessings == 1.6 14:35:32 INFO - blobuploader == 1.2.4 14:35:32 INFO - docopt == 0.6.1 14:35:32 INFO - manifestparser == 1.1 14:35:32 INFO - mozInstall == 1.12 14:35:32 INFO - mozcrash == 0.17 14:35:32 INFO - mozdebug == 0.1 14:35:32 INFO - mozdevice == 0.48 14:35:32 INFO - mozfile == 1.2 14:35:32 INFO - mozhttpd == 0.7 14:35:32 INFO - mozinfo == 0.9 14:35:32 INFO - mozleak == 0.1 14:35:32 INFO - mozlog == 3.1 14:35:32 INFO - moznetwork == 0.27 14:35:32 INFO - mozprocess == 0.22 14:35:32 INFO - mozprofile == 0.28 14:35:32 INFO - mozrunner == 6.11 14:35:32 INFO - mozscreenshot == 0.1 14:35:32 INFO - mozsystemmonitor == 0.0 14:35:32 INFO - moztest == 0.7 14:35:32 INFO - mozversion == 1.4 14:35:32 INFO - psutil == 3.1.1 14:35:32 INFO - requests == 1.2.3 14:35:32 INFO - wsgiref == 0.1.2 14:35:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:32 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')]} 14:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 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')]} 14:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 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 0x109d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d74420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95094697a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c03e00>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bfeb20>, '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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 14:35:32 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 14:35:32 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 14:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bjwIXlBL3Q/Render', 14:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:32 INFO - 'HOME': '/Users/cltbld', 14:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:32 INFO - 'LOGNAME': 'cltbld', 14:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:32 INFO - 'MOZ_NO_REMOTE': '1', 14:35:32 INFO - 'NO_EM_RESTART': '1', 14:35:32 INFO - 'PAGER': '/bin/cat', 14:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:32 INFO - 'PWD': '/builds/slave/test', 14:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:32 INFO - 'SHELL': '/bin/bash', 14:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hPC4BGTfzz/Listeners', 14:35:32 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 14:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:32 INFO - 'USER': 'cltbld', 14:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:32 INFO - 'XPC_FLAGS': '0x0', 14:35:32 INFO - 'XPC_SERVICE_NAME': '0', 14:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 INFO - Cleaning up... 14:35:32 INFO - Return code: 0 14:35:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:35:32 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')]} 14:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 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')]} 14:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 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 0x109d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d74420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95094697a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c03e00>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bfeb20>, '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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 14:35:32 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 14:35:32 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 14:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bjwIXlBL3Q/Render', 14:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:32 INFO - 'HOME': '/Users/cltbld', 14:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:32 INFO - 'LOGNAME': 'cltbld', 14:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:32 INFO - 'MOZ_NO_REMOTE': '1', 14:35:32 INFO - 'NO_EM_RESTART': '1', 14:35:32 INFO - 'PAGER': '/bin/cat', 14:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:32 INFO - 'PWD': '/builds/slave/test', 14:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:32 INFO - 'SHELL': '/bin/bash', 14:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hPC4BGTfzz/Listeners', 14:35:32 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 14:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:32 INFO - 'USER': 'cltbld', 14:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:32 INFO - 'XPC_FLAGS': '0x0', 14:35:32 INFO - 'XPC_SERVICE_NAME': '0', 14:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:33 INFO - Downloading/unpacking jsonschema 14:35:33 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 14:35:33 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 14:35:33 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 14:35:33 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 14:35:33 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 14:35:33 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 14:35:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:35:35 INFO - Downloading/unpacking functools32 (from jsonschema) 14:35:35 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 14:35:35 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 14:35:35 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 14:35:35 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 14:35:35 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 14:35:35 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 14:35:35 INFO - Downloading functools32-3.2.3-2.tar.gz 14:35:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:35:35 INFO - warning: no files found matching '*.txt' 14:35:35 INFO - no previously-included directories found matching 'build' 14:35:35 INFO - no previously-included directories found matching 'dist' 14:35:35 INFO - no previously-included directories found matching '.git*' 14:35:36 INFO - Installing collected packages: jsonschema, functools32 14:35:36 INFO - Running setup.py install for functools32 14:35:36 INFO - warning: no files found matching '*.txt' 14:35:36 INFO - no previously-included directories found matching 'build' 14:35:36 INFO - no previously-included directories found matching 'dist' 14:35:36 INFO - no previously-included directories found matching '.git*' 14:35:36 INFO - Successfully installed jsonschema functools32 14:35:36 INFO - Cleaning up... 14:35:36 INFO - Return code: 0 14:35:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d74420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95094697a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c03e00>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bfeb20>, '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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 14:35:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:35:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bjwIXlBL3Q/Render', 14:35:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:36 INFO - 'HOME': '/Users/cltbld', 14:35:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:36 INFO - 'LOGNAME': 'cltbld', 14:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:36 INFO - 'MOZ_NO_REMOTE': '1', 14:35:36 INFO - 'NO_EM_RESTART': '1', 14:35:36 INFO - 'PAGER': '/bin/cat', 14:35:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:36 INFO - 'PWD': '/builds/slave/test', 14:35:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:36 INFO - 'SHELL': '/bin/bash', 14:35:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hPC4BGTfzz/Listeners', 14:35:36 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 14:35:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:36 INFO - 'USER': 'cltbld', 14:35:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:36 INFO - 'XPC_FLAGS': '0x0', 14:35:36 INFO - 'XPC_SERVICE_NAME': '0', 14:35:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:36 INFO - Downloading/unpacking flake8 14:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:35:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:35:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:35:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:35:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:35:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:35:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:35:40 INFO - no previously-included directories found matching 'docs/_build' 14:35:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:35:40 INFO - Running setup.py install for pep8 14:35:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:35:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:35:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:35:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:35:40 INFO - no previously-included directories found matching 'docs/_build' 14:35:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:35:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:35:40 INFO - Cleaning up... 14:35:40 INFO - Return code: 0 14:35:40 INFO - Running post-action listener: _resource_record_post_action 14:35:40 INFO - Running post-action listener: _start_resource_monitoring 14:35:40 INFO - Starting resource monitoring. 14:35:40 INFO - ##### 14:35:40 INFO - ##### Running install step. 14:35:40 INFO - ##### 14:35:40 INFO - Running pre-action listener: _resource_record_pre_action 14:35:40 INFO - Running main action method: install 14:35:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:41 INFO - Reading from file tmpfile_stdout 14:35:41 INFO - Detecting whether we're running mozinstall >=1.0... 14:35:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:35:41 INFO - Reading from file tmpfile_stdout 14:35:41 INFO - Output received: 14:35:41 INFO - Usage: mozinstall [options] installer 14:35:41 INFO - Options: 14:35:41 INFO - -h, --help show this help message and exit 14:35:41 INFO - -d DEST, --destination=DEST 14:35:41 INFO - Directory to install application into. [default: 14:35:41 INFO - "/builds/slave/test"] 14:35:41 INFO - --app=APP Application being installed. [default: firefox] 14:35:41 INFO - mkdir: /builds/slave/test/build/application 14:35:41 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'] 14:35:41 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 14:36:15 INFO - Reading from file tmpfile_stdout 14:36:15 INFO - Output received: 14:36:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:36:15 INFO - Running post-action listener: _resource_record_post_action 14:36:15 INFO - ##### 14:36:15 INFO - ##### Running run-tests step. 14:36:15 INFO - ##### 14:36:15 INFO - Running pre-action listener: _resource_record_pre_action 14:36:15 INFO - Running main action method: run_tests 14:36:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:36:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:36:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:36:15 INFO - 2016-03-25 14:36:15.462 screenresolution[2621:17572] starting screenresolution argv=screenresolution get 14:36:15 INFO - 2016-03-25 14:36:15.465 screenresolution[2621:17572] Display 0: 1600x1200x32@60 14:36:15 INFO - 2016-03-25 14:36:15.471 screenresolution[2622:17574] starting screenresolution argv=screenresolution list 14:36:15 INFO - Available Modes on Display 0 14:36:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:36:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:36:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:36:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:36:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:36:15 INFO - Intel Iris: 14:36:15 INFO - Chipset Model: Intel Iris 14:36:15 INFO - Type: GPU 14:36:15 INFO - Bus: Built-In 14:36:15 INFO - VRAM (Dynamic, Max): 1536 MB 14:36:15 INFO - Vendor: Intel (0x8086) 14:36:15 INFO - Device ID: 0x0a2e 14:36:15 INFO - Revision ID: 0x0009 14:36:15 INFO - Displays: 14:36:15 INFO - Display: 14:36:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:36:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:36:15 INFO - Display Serial Number: 1600x1200 60 14:36:15 INFO - Main Display: Yes 14:36:15 INFO - Mirror: Off 14:36:15 INFO - Online: Yes 14:36:15 INFO - Rotation: Supported 14:36:15 INFO - Return code: 0 14:36:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:36:15 INFO - Python 2.7.3 14:36:15 INFO - Return code: 0 14:36:15 INFO - grabbing minidump binary from tooltool 14:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:15 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 0x109c03e00>, '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 0x109a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bfeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:36:15 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 14:36:15 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 14:36:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:36:15 INFO - Return code: 0 14:36:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:36:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:36:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:36:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:36:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:36:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:36:17 INFO - Return code: 0 14:36:17 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:36:17 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0177 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:36:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bjwIXlBL3Q/Render', 14:36:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:36:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:36:17 INFO - 'HOME': '/Users/cltbld', 14:36:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:36:17 INFO - 'LOGNAME': 'cltbld', 14:36:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:36:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:17 INFO - 'MOZ_NO_REMOTE': '1', 14:36:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:36:17 INFO - 'NO_EM_RESTART': '1', 14:36:17 INFO - 'PAGER': '/bin/cat', 14:36:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:17 INFO - 'PWD': '/builds/slave/test', 14:36:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:36:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:36:17 INFO - 'SHELL': '/bin/bash', 14:36:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hPC4BGTfzz/Listeners', 14:36:17 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 14:36:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:36:17 INFO - 'USER': 'cltbld', 14:36:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:36:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:17 INFO - 'XPC_FLAGS': '0x0', 14:36:17 INFO - 'XPC_SERVICE_NAME': '0', 14:36:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:36:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:36:17 INFO - mozversion application_buildid: 20160325134240 14:36:17 INFO - mozversion application_changeset: 28a35458f825099bb18ea5af6dd92d85c660f7b9 14:36:17 INFO - mozversion application_display_name: Nightly 14:36:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:36:17 INFO - mozversion application_name: Firefox 14:36:17 INFO - mozversion application_remotingname: firefox 14:36:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:36:17 INFO - mozversion application_vendor: Mozilla 14:36:17 INFO - mozversion application_version: 48.0a1 14:36:17 INFO - mozversion platform_buildid: 20160325134240 14:36:17 INFO - mozversion platform_changeset: 28a35458f825099bb18ea5af6dd92d85c660f7b9 14:36:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:36:17 INFO - mozversion platform_version: 48.0a1 14:36:17 INFO - using testdate: 1458941777 14:36:17 INFO - actual date: 1458941777 14:36:17 INFO - starting webserver on 'localhost:49741' 14:36:17 INFO - SUITE-START | Running 2 tests 14:36:17 INFO - TEST-START | dromaeo_css 14:36:17 INFO - operating with platform_type : mac_ 14:36:17 INFO - Initialising browser for dromaeo_css test... 14:36:17 INFO - TEST-INFO | started process 2640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmptR_tW_/profile http://localhost:49741/getInfo.html) 14:36:19 INFO - PROCESS | 2640 | __metrics Screen width/height:1600/1200 14:36:19 INFO - PROCESS | 2640 | colorDepth:24 14:36:19 INFO - PROCESS | 2640 | Browser inner width/height: 1024/689 14:36:19 INFO - PROCESS | 2640 | __metrics 14:36:19 INFO - PROCESS | 2640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:36:19 ERROR - PROCESS | 2640 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:36:20 INFO - TEST-INFO | 2640: exit 0 14:36:20 INFO - Browser initialized. 14:36:20 INFO - Running cycle 1/1 for dromaeo_css test... 14:36:20 INFO - TEST-INFO | started process 2643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmptR_tW_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:36:32 INFO - PROCESS | 2643 | RSS: Main: 244039680 14:36:32 INFO - PROCESS | 2643 | 14:37:23 INFO - PROCESS | 2643 | 1458941843349 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] 14:39:33 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:49741/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49741/tests/dromaeo/cssquery-ext.html) 14:39:35 INFO - PROCESS | 2643 | RSS: Main: 381517824 14:39:35 INFO - PROCESS | 2643 | 14:42:37 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:49741/tests/dromaeo/cssquery-ext.html (next: http://localhost:49741/tests/dromaeo/cssquery-jquery.html) 14:42:38 INFO - PROCESS | 2643 | RSS: Main: 380542976 14:42:38 INFO - PROCESS | 2643 | 14:45:40 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:49741/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49741/tests/dromaeo/cssquery-mootools.html) 14:45:40 INFO - PROCESS | 2643 | RSS: Main: 376528896 14:45:40 INFO - PROCESS | 2643 | 14:48:42 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:49741/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49741/tests/dromaeo/cssquery-prototype.html) 14:48:43 INFO - PROCESS | 2643 | RSS: Main: 336019456 14:48:43 INFO - PROCESS | 2643 | 14:51:46 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:49741/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49741/tests/dromaeo/cssquery-yui.html) 14:51:47 INFO - PROCESS | 2643 | RSS: Main: 335958016 14:51:47 INFO - PROCESS | 2643 | 14:54:49 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:49741/tests/dromaeo/cssquery-yui.html (next: http://localhost:49741/tests/dromaeo/cssquery-dojo.html) 14:54:50 INFO - PROCESS | 2643 | RSS: Main: 420278272 14:54:50 INFO - PROCESS | 2643 | 14:54:50 INFO - PROCESS | 2643 | __start_tp_report 14:54:50 INFO - PROCESS | 2643 | _x_x_mozilla_page_load 14:54:50 INFO - PROCESS | 2643 | _x_x_mozilla_page_load_details 14:54:50 INFO - PROCESS | 2643 | |i|pagename|runs| 14:54:50 INFO - PROCESS | 2643 | |0;dojo.html;3374.9156271093225;3413.6245013048547;3439.8108104054268;3457.4468085106373;3508.4035713928647;5559.749811258493;5577.107662773957;5600.523955463786;5625.5499560035205;5631.155326701002;5654.264945557082;5668.68822214778;5686.1186516089965;5773.249477567911;5786;5089.770960306777;5099.872503187422;5131.281620573104;5149.845504634848;5208.713520756357;5220.556252718524;5226.634135610509;5260.447652996438;5273.156294992802;5307.150855863063;5060.822871199527;5087.66930149541;5173.224016397533;5174.689518628894;5211.817586384496;5163.302954101186;5165.948340516585;5176.55999240065;5195.272661827347;5217.5565076968505;5100.821471248526;5122.282880396748;5144.305518754958;5165.276861239429;5191.325127733408;5478.561715062825;5558.583106267046;5605.775768969236;5610.410906854803;5668.801591944303;6163.1679723237685;6164.784232551884;6169.9383006170265;6170.814875553696;6175.228096487939;6196.721147548371;6226.315105338409;6243;6263.624182549016;6268.341824108448;4779.880502987384;5600.187972743929;5679.602427830012;5725.370209277018;5753.108268218432;6335.239771227482;6361.745530178741;6364.363563643691;6378.266499352541;6387.233531976192;5965.433283838029;5976.432238937294;6019.006863867413;6022.2171117754415;6040.275166979991;6068.969655151696;6106.877862442726;6125.021800333839;6160.44555989963;6165.537584681167;6083.148359229712;6084.775645005126;6109.647596799064;6112.989854784112;6132.386761323832;6143.815685529352;6145.4161854623735;6150.600210986271;6154.661493617805;6155.630662160284;4689.577937985529;4705.200115980291;4760.690555113906;4763.54746299101;4764.6664733469015;4385.386045953569;4420.845270415584;4421.29259318514;4422.690411671217;4435.534268901783;5537.8061767837935;5591.133374326986;5595.356533998643;5595.636283641632;5634.943650563442;6115.909724157157;6126.120738204466;6127.433875357673;6239.75040998355;6277.24673039229;4689.742064186435;5587.497125258747;5600.607957443021;5601.103823388238;5626.606137570413;5291.365036195682;5294.047071527085;5300.973495132577;5305.734713264322;5341.332333458317;6242.157308763259;6269.62382257066;6341.270753863272;6352.460040896575;6385;6182.1345011697495;6209.751609935552;6212.285587157535;6217.4715149212825;6226.657533835682;6209.59637623553;6338;6367.586106903036;6369.1401660777055;6380.968095159495;6000.399960003964;6078.756849725962;6096.466212027279;6098.91636565712;6110.103144028831;6180.783672571618;6191.473724733448;6211.565190436807;6212.285587157354;6217.626942383471;5849.298084229919;5865.970670146793;5917.822465326047;5947.732352044082;5948.196993405835;5963.9105413417965;5977.671228082497;5979.760809567569;6002.7298771554515;6023.247094113236;4855.34452848875;5810.448007439287;5852.122181672613;5855.38518455556;5874;5491.615586909038;5589.832305030855;5733.556493717402;5943.791967281124;6067.362926892612;5874.030784920611;5875.294964604275;5890.204822349099;5890.646561206341;5934.43622855828 14:54:50 INFO - PROCESS | 2643 | |1;ext.html;487.7561219390305;542.9185622156676;569.9029368465705;628.0798630007039;636.0745115856429;38265;38809;38834.80582597086;38866.99999999996;38912.027199319964;41797.58202417975;42181.578184218146;42272;42321;42386.15227695444;8266.669333226664;8276.83446331073;9373.76565585859;9587.328886977879;9589.712308630717;9559.617615295414;9722.756931076745;9734.610615575368;9738.561764720605;9741.17200037994;9684.467354295512;9755.707328780149;9760.560774765152;9766.316357854954;9774.511274436285;9655.951720241388;9735.221182305399;9748.171405430512;9772.31593788435;9798.265130115198;9445.149936505679;9496;9666.565004574812;9670.75823104428;9681.322307438482;40381.990450238685;40728.59271407278;40814;40817.387739183934;40841.387379189335;3235.773495855291;3255.462848629973;3271.188038726264;3274.607047154333;3491.6159222485508;28643.57034644482;28836.423271534662;29099;29118;29965.850170749225;2708.986455067712;2861.570764385338;2899.2027192522014;2899.5070837957596;2900.9274768130754;494980;498281.5085924583;499146;499186;499801;61143.388566114656;63158.68420657867;63398.68300658467;63454.68272658607;63515.87146835441;66280.00579991304;66285;66661;66695.33304666891;66816;16838.073905935293;17065.402710905306;17077.12151663316;17083.743743843603;17108.48674539766;13029.413676384585;13138.868611313956;13142;13143.211407315592;13189.934050329686;17979.345938965067;18939;19357.322493712654;19405.611887762167;19492.512687182934;6380.55336126476;6965.547239429522;7070.797964346074;7735.1491335953;7812.843743125106;915.4278575890069;963.4219468318953;996.9152622027063;1010.4745532323298;1107.5735841701003;27877;28441.57337639937;28555.857220713762;28591.714082859322;28612;1010.701842956315;1064.4677661169414;1185.875483074282;1214.979417289481;1234.9444275007647;14860.479883204036;14882.69318255672;14923.403063877324;15184.392624295126;15230.46693365727;521623;525969;527331;527441;529680;59122.11316830251;59374.40625593689;59396.7030164855;59501;59597.404025959186;1318.4528420705492;1438.1155589312707;1447.5946734914241;1456.4538298138198;1478.046659904377;28099.859500702365;28690.56964145581;29232.70767292385;29298.707012929597;29529.704702953553;44288;46289.53710462987;47026.76486617545;47152;47233;362338;366108;366253;366259;366540;28040.719592804628;32017.199570010936;32504.512432314008;33127;33785.49321760225;41101.17797643971;42013;42051.57948420477;42094.57905420907;42796.78601607097;31400;32178.35643287168;33868;34646;35243;34137;34138.14654633654;34727.82636086905;34772.47841282332;35009.64990350064;34945.47581786326;35251;35603.10992225215;35934.92195234147;35986.64013359938;26850.32874178161;30525.084247472612;31695.683043169272;31711.524327135572;31858.362832743678;23596.764032359457;23827.285181444586;23839.756237668134;23917.40206494782;24041.398965026016 14:54:50 INFO - PROCESS | 2643 | |2;jquery.html;360.22012343276805;361.9764715293506;362.9546306711661;372.4692313453332;372.54363404829087;15725.84274157258;20096.995150242485;21193.470163245926;21601.1359545618;21617.45956351092;19582.216711331566;20300.390988270374;21136.788632113676;21143.577128457422;21148.154073837068;5557.944420555803;5725.398833122525;5739.540836733072;5774;5796;4161.292580261348;4440.777961101932;5651.491365777079;6323.620582765026;6351.460125889305;6155.846103847417;6304.495640348784;6311.368863113697;6312.558120931537;6342.682865856688;6091.0863370494335;6217.036359364283;6301.6534090625;6310;6315.589486683374;5405.621606487547;5409.972950135263;5430.402655707869;5434.565234781247;5439.428859969726;25307.240782776546;25917.870410647825;26039.609405858737;26138.73861261382;26313.3421664458;2161.103142195987;2181.2801775414077;2220.455988282881;2728;2838.5316422790215;14356.928215358856;14885.404583816635;14992.70014599702;15022.173780442072;15365.923170384189;1741.3469948769211;1794.3450640516248;1804.639072185555;1814.5645045189192;1827.044448768415;79739.20260797376;98353;99941;101507;102553.48723256336;10144.746381340377;10265.435401052864;10477.84283235752;10515.894841051644;10589.364638121737;10964.780704385868;12973.924172132414;13079.607611771662;13083.215007099605;13117.803232951514;8348.791280217922;8530.616122274512;8627;8642.611082501302;8802.955985220033;8792.736217913473;8799.032106468283;8799.516026618598;8895.555222238861;8898.4660920345;5972.552058595623;6054.8183554493435;6069.180660610849;6093.238345206849;6131.14164017038;1546.3505327762366;1673.6987342278508;1780.1188411736014;1791.7939436964655;1813.7642106526066;821.6138414944967;980.8670985012322;1012.5089331674133;1017.9694609161737;1027.6968294353185;17737.645247094984;19390.8060919389;19527.60944781125;20612.793872061087;21154.894225528773;950.8050849575959;951.2437612098398;970.1414248390084;983.6606370802061;1019.8521214423866;8916.777080573038;10996.350547417791;11367.772644547063;11381.317120972768;11406.828897566544;615535;620297;628038.756899447;644551;646457;79836.60898650513;98293;98344;107157;107467.46266268619;1022.5807418958192;1027.7225149209671;1031.0514326819193;1055.994720026395;1058.730023843915;18037.549061273574;18270.086495674896;18342.17460214267;18489.81510184881;18504.81495185031;42964.35553466638;44237.55762442463;46572;47032.52967470281;47240;53048.204276936645;68497;68511.31488685249;69845;70840.29159708337;6194.787107043303;7624.961875190588;7629.046369203849;7826.2173782621285;8001.479903806234;12339;12375.648626760887;12533.185342952678;12738.745225095261;12829.973602111995;10782.514786834454;10897.618583349546;11284.32294062359;11289.435528223721;11314.490847911698;10784.622538211124;10785.73035674083;10969.464275001666;10991.06575941022;11254.268472549258;11283.492242848928;11329.773404531697;11344.20590558686;11446.94276528612;11534.82697759551;6269.717862696099;7654.119776225805;7689.807754806175;7745.728899488491;7809.258120478546;10939.179561533076;11098.334099954029;11347.773044539228;11361.772764544497;11403 14:54:50 INFO - PROCESS | 2643 | |3;mootools.html;1442.5239670908602;1577.8797054091594;1608.5576466471723;1850.8056654051325;1969.675003624402;7938.761837144888;8646.567671616418;8773.912260877389;8788.077251888555;8798.604062817172;8429.91570084299;8663.956680216606;8677.869831952527;8685.782855428617;8698.043215246318;2161.945951351213;2414.4929564791414;2460.1635443949053;2483.863387513686;2493.8628375439343;2345.3901985483726;2458.6926634170727;2485.9751402485927;2491.9127830525936;2497.0386401235473;2425.463896031692;2477.9876100619563;2506.862122583257;2508.3227528567277;2509.2095989763257;2473.4311108445067;2493.5760920643443;2499.8875050622673;2517.332906779705;2519.44572194117;2460.963085553718;2488.8008959283393;2499.225240175533;2506.0852788732163;2506.8119891008246;8751.912480875173;8796.032436432051;8826.602802873886;8845.911540884637;8847.73456796297;5372.758225879845;5523.392426833045;5528.944710552923;5561.277033985596;5562.86092847678;3331.933361332784;3449.137715571107;3523.541939547868;3698.593154752975;3702.2595480903656;1046.905778479933;1062.6440142552176;1067.0983019348637;1075.4783929794044;1081.874850155837;11838.644840654793;11850.466728997217;11853.111016673784;11856.170068095236;11870.584529541511;4771.66598338113;4820.807167713322;4889.604093993918;4913.680610760289;4925.9014819704125;10046.69859904204;10047;10048.045435683598;10061.949690251648;10084.848727269096;5481.040817856859;5488.396276409591;5524.1989911462615;5524.696141712245;5527.198556209327;4381.605655491021;4533.77331133442;4885.340479035356;4957.529034741694;4957.900841983213;3790.469334293201;3879.689624830007;3884.6892248620043;3915.334393153171;3938.7439816411843;1153.7424207613574;1292.4894666606638;1322.5238913990956;1329.9069065165345;1339.9866001339863;1354.1942544186193;1374.0450386980951;1395.0722769358465;1397.2385050147693;1400.3138462153472;7997.400194985399;8174.713885013996;8187.304079153219;8188.099309075997;8192.713255036046;480.7908111100585;493.56812788809793;511.2382550000473;528.801699362739;529.9655522391032;5862.912056319158;6165.599236049642;6216.595921265103;6218.81343559694;6223.253209614875;10282.897171028193;10713.625023124308;10737.550430691912;10826.18803589734;10860;9382.577783999737;10256.948715256376;10261.897381026243;10647.094996925349;10664.360138391567;8308.169183081643;8328.875066874001;8351.206635369508;8400.117987611213;8403.663853445916;7797.142314345304;7862.567558784322;7873.055233372032;7899.84200315979;7922.0889597697005;9477.810443791224;9530.428174309563;9569;9570.61717531291;9597.47213903242;9754.658586949707;9833.60665573369;10009.299349045788;10126.13927816144;10129.341592796445;6789.830254243683;6869.828254293682;7313.963430182815;7487.438442116754;7573.166951635206;8233.217844304781;8356.749297521084;8360.749177524684;8367.748967530984;8370.37222208349;7245.529040612343;7368.815779605553;7379.188289288067;7497.850042999218;7521.736739214101;7150.177729561167;7197.640117993975;7218.602976836324;7248.710051597877;7348.742794002184;7653.846923061396;7737.3423259021365;7741.07107147146;7742.7677169685;7747.806304842424;6950.131233595801;6978.337057979484;7027.15674119109;7039.436845052486;7045.506814522934;7117.6085315308155;7193.964030179815;7194.244604316681;7213.819654508469;7214.74748383804 14:54:50 INFO - PROCESS | 2643 | |4;prototype.html;325.07840272826536;328.3891960952628;332.2590622910907;335.27580426279235;337.28327304477966;5227.660202086861;6489.578177418471;6520.576162549431;6570.572912760673;6583.440407565363;6488.610683359002;6499.577527460712;6506.284308726036;6507.05647681086;6541.934580654192;4635.374224479702;4736.4789873114105;4812.23004319309;4874.098291816025;4874.6831455955335;4816.638752093607;4825.420949486067;4847.248676455155;4856.68431551948;4859.902801943959;3906.570277269498;4246.723962942414;4458.242098843189;4767.713937163781;4793.3528973588645;4592.173408786417;4682.1338052460405;4768.046390721869;4780.760961951889;4783.4977327380475;4085.5914408558906;4091.7954102294766;4095.1604920991126;4096;4104.610062044101;5103.260027296058;6196.380361963767;6221.502279817604;6221.5333849961435;6251.531135164881;4622.214223581999;5601.243832082698;5613.719314034322;5624.100143976944;5624.268845050117;6843.62360070196;6862.965685171592;6866.690998905061;6872.278410766898;6880.552764070319;4350.347447882811;4534.38785763921;4538.137753826795;4547.567981041796;4552.749598772066;7177.021536062528;7306.963465182694;7316.122065352139;7328.78013659591;7330.413566914634;4560.566746159109;4561.908761824745;4580.8167673293365;4581.198290299184;4593.379893714306;4637.698549594265;4648.930266046012;4651.488336283006;4651.837185698552;4664.370310008173;5530.11518157101;5530.723463826793;5533.280673512418;5542.140968149944;5544.556435485151;6659.766908158192;6918.308169183142;6942.618156001367;6949.861002779916;6959;1663.4593757028772;1675.4973507947566;1689.4340395967488;1690.653416049707;1691.196681576266;1030.407515678488;1063.8670166229222;1089.5641743302742;1093.2729734726317;1116.2465335898398;6459;6604.306547812506;6605.669716514155;6624.96687516569;6628.171478565179;7260.6006669632625;7267.527610705287;7269.963650181715;7278.781636550912;7281.381082608038;6537.280899101095;6542.934570654233;6554.442872355903;6555.541112122201;6561.179852518435;3795.772253664789;3842.289176502356;3845.576986531479;3847.3074846527893;3848.6728628066367;7211.819704507429;7488.063992001;7500.58746768922;7502.624868756649;7545.547267163988;7444.292792184734;7500.912367706652;7502.17476077631;7505.174430812606;7514.135874374517;7535.886961695579;7541.849163016709;7543.434242431839;7546.622668866535;7555.16893141743;5046.949530504648;6322.620642761449;6843.520953533205;7242.927570724225;7269.672864720995;7115.5730656160795;7129.714811407693;7174.210836808052;7175.354218120394;7187.137543494814;7528.548287102792;7576.181716387917;7595.506292091218;7604.163542010485;7608.923910760822;4571.862844114682;4624.28323609841;4626.976865115653;4632.7954731769305;4651.5813576778255;6936.583804971718;7162.7493037743425;7193.064901562972;7199.280071992759;7213.3868621167785;6486.54594178403;6882.621455819978;6958.921367188094;6979.092717946634;7002.649867506706;6903.1716194055025;6942.652867356713;6942.757003504853;6953.826154346182;6958.686859091455;6112.144299797943;6275.309715931153;6811.318868113149;6811.625360605214;6823.089534930029;6666.866662666816;6941.34057264559;6945.305469453217;6956.860862782817;6957.582545047313;6567.605943643397;6719.563228390139;6768.492363072888;6794.660266986532;6881.311868813079 14:54:50 INFO - PROCESS | 2643 | |5;yui.html;701.9227884932658;708.022928358865;711.2460791560943;729.824842037911;741.762635956494;15050.548483545497;17628.294868205274;18009.459716208534;18045.278188872464;18069.186886590087;16335.83664163358;16440.75338869918;16487.83512164878;16523.91738041308;16559.006459612432;749.9850002999937;921.6221349246811;947.199616324205;948.4025064209573;952.8475443928972;750.9173990861001;751.8533885892253;753.5328096580128;757.3221966340122;807.5800583696474;968.6706519783272;974.2449601558777;976.8534719792017;977.9022097790236;977.9559919803626;969.5636963366478;970.2868391732071;971.0774763974182;972.2416515118219;974.3666616699131;513.9820106296299;712.2130046298817;723.222535774045;724.7427163356986;725.8366867454833;15378.615534611725;15422.845771542365;15456.149911754848;15469.071855688582;15485.612859678486;10398.428086455242;12303.507859685602;12333.260004399765;12432.875671243262;12442.253464792051;9839.212862970946;9889.20886329092;9952.950235248778;9973.252006099572;10226.948865255627;3064.5709600655928;3415.624281329052;3436.7937923724407;3495.2485215678753;3512.8594856205978;83940;85678;85680.57159714223;85975;86756.6986495203;9310.882694076754;9448.669296574586;9570.186534144676;9661.806763864683;9793.804123917482;21400.82295473764;21426.03582838776;21456.356309310744;21469.46326341854;21474.892625536773;7235.6020418876415;7370.078740157481;7426.760577371989;7434.73978410753;7485.625718714152;4081.2041651878194;4082.2243773682903;4163.10493243954;4181.498220213593;4281.05816720321;3619.4027985382645;3678.0988657779017;3681.7606855554304;3690.9261814763554;3697.482352470656;633.338161621107;635.7139287320724;644.861354808709;665.411111166621;673.4174938678008;516.4551398274781;540.6701911833857;582.6911736779514;594.9732262048218;608.716946619824;8215.548144852091;8230.135835737161;8235.629396677165;8415.70545030921;8425.662973481114;536.8389483155038;594.5184400635499;618.2210414877197;622.5548732656173;628.9967501834567;3735.364987952055;3776.2258736958856;3795.9240815183543;3807.466954626299;4035.051762835731;96857.51571242098;97745;98514.02971940664;101162.42444241101;101242.49378753059;78919.21080789233;79718.80421793678;82910;83939.74090388649;85202.57398712967;59432.405675943555;72216.277837222;73313;74165;74505;7771.961140194489;7782.688692452239;7873.606319684108;7886.802829929297;7967.402444816546;49265.75367123142;51037.48962510328;51605;51820.481795181564;52295.47704523058;56179.71910140423;65179.34820651922;70486;70612;72469.6376518114;9904.108630223314;9920.355176913477;10895.891041089488;11173.944130279297;11383.684116206223;11676.124290678063;11925.926666600048;12084.154109212272;12299.69250768738;12951.287679177736;11185.049270812073;11606.477708503306;11638.6508404748;11768.764624707286;12098.455569499569;10869.239153259196;11184.720381990515;11698.122640801803;11915.761684766083;11978.880211198126;11273.098152147972;11355.886441135814;11458.541658333574;11535.779743405701;11730.70673233176;9622.278329125204;9669.226461883172;9755.365901216399;9932.950335248277;10636.52135653882;7695.384369250559;8848.247898928663;9167.312451566293;9574.95212523933;9761 14:54:50 INFO - PROCESS | 2643 | __end_tp_report 14:54:50 INFO - PROCESS | 2643 | __start_cc_report 14:54:50 INFO - PROCESS | 2643 | _x_x_mozilla_cycle_collect,1233 14:54:50 INFO - PROCESS | 2643 | __end_cc_report 14:54:50 INFO - PROCESS | 2643 | __startTimestamp1458942890094__endTimestamp 14:54:50 INFO - PROCESS | 2643 | 14:54:50 INFO - PROCESS | 2643 | ------- Summary: start ------- 14:54:50 INFO - PROCESS | 2643 | Number of tests: 6 14:54:50 INFO - PROCESS | 2643 | 14:54:50 INFO - PROCESS | 2643 | [#0] dojo.html Cycles:165 Average:5662.39 Median:5855.39 stddev:636.46 (10.9%) stddev-sans-first:612.60 14:54:50 INFO - PROCESS | 2643 | Values: 3374.9 3413.6 3439.8 3457.4 3508.4 5559.7 5577.1 5600.5 5625.5 5631.2 5654.3 5668.7 5686.1 5773.2 5786.0 5089.8 5099.9 5131.3 5149.8 5208.7 5220.6 5226.6 5260.4 5273.2 5307.2 5060.8 5087.7 5173.2 5174.7 5211.8 5163.3 5165.9 5176.6 5195.3 5217.6 5100.8 5122.3 5144.3 5165.3 5191.3 5478.6 5558.6 5605.8 5610.4 5668.8 6163.2 6164.8 6169.9 6170.8 6175.2 6196.7 6226.3 6243.0 6263.6 6268.3 4779.9 5600.2 5679.6 5725.4 5753.1 6335.2 6361.7 6364.4 6378.3 6387.2 5965.4 5976.4 6019.0 6022.2 6040.3 6069.0 6106.9 6125.0 6160.4 6165.5 6083.1 6084.8 6109.6 6113.0 6132.4 6143.8 6145.4 6150.6 6154.7 6155.6 4689.6 4705.2 4760.7 4763.5 4764.7 4385.4 4420.8 4421.3 4422.7 4435.5 5537.8 5591.1 5595.4 5595.6 5634.9 6115.9 6126.1 6127.4 6239.8 6277.2 4689.7 5587.5 5600.6 5601.1 5626.6 5291.4 5294.0 5301.0 5305.7 5341.3 6242.2 6269.6 6341.3 6352.5 6385.0 6182.1 6209.8 6212.3 6217.5 6226.7 6209.6 6338.0 6367.6 6369.1 6381.0 6000.4 6078.8 6096.5 6098.9 6110.1 6180.8 6191.5 6211.6 6212.3 6217.6 5849.3 5866.0 5917.8 5947.7 5948.2 5963.9 5977.7 5979.8 6002.7 6023.2 4855.3 5810.4 5852.1 5855.4 5874.0 5491.6 5589.8 5733.6 5943.8 6067.4 5874.0 5875.3 5890.2 5890.6 5934.4 14:54:50 INFO - PROCESS | 2643 | 14:54:50 INFO - PROCESS | 2643 | [#1] ext.html Cycles:180 Average:60971.84 Median:366399.50 stddev:124635.83 (34.0%) stddev-sans-first:124902.73 14:54:50 INFO - PROCESS | 2643 | Values: 487.8 542.9 569.9 628.1 636.1 38265.0 38809.0 38834.8 38867.0 38912.0 41797.6 42181.6 42272.0 42321.0 42386.2 8266.7 8276.8 9373.8 9587.3 9589.7 9559.6 9722.8 9734.6 9738.6 9741.2 9684.5 9755.7 9760.6 9766.3 9774.5 9656.0 9735.2 9748.2 9772.3 9798.3 9445.1 9496.0 9666.6 9670.8 9681.3 40382.0 40728.6 40814.0 40817.4 40841.4 3235.8 3255.5 3271.2 3274.6 3491.6 28643.6 28836.4 29099.0 29118.0 29965.9 2709.0 2861.6 2899.2 2899.5 2900.9 494980.0 498281.5 499146.0 499186.0 499801.0 61143.4 63158.7 63398.7 63454.7 63515.9 66280.0 66285.0 66661.0 66695.3 66816.0 16838.1 17065.4 17077.1 17083.7 17108.5 13029.4 13138.9 13142.0 13143.2 13189.9 17979.3 18939.0 19357.3 19405.6 19492.5 6380.6 6965.5 7070.8 7735.1 7812.8 915.4 963.4 996.9 1010.5 1107.6 27877.0 28441.6 28555.9 28591.7 28612.0 1010.7 1064.5 1185.9 1215.0 1234.9 14860.5 14882.7 14923.4 15184.4 15230.5 521623.0 525969.0 527331.0 527441.0 529680.0 59122.1 59374.4 59396.7 59501.0 59597.4 1318.5 1438.1 1447.6 1456.5 1478.0 28099.9 28690.6 29232.7 29298.7 29529.7 44288.0 46289.5 47026.8 47152.0 47233.0 362338.0 366108.0 366253.0 366259.0 366540.0 28040.7 32017.2 32504.5 33127.0 33785.5 41101.2 42013.0 42051.6 42094.6 42796.8 31400.0 32178.4 33868.0 34646.0 35243.0 34137.0 34138.1 34727.8 34772.5 35009.6 34945.5 35251.0 35603.1 35934.9 35986.6 26850.3 30525.1 31695.7 31711.5 31858.4 23596.8 23827.3 23839.8 23917.4 24041.4 14:54:50 INFO - PROCESS | 2643 | 14:54:50 INFO - PROCESS | 2643 | [#2] jquery.html Cycles:180 Average:34022.45 Median:25612.56 stddev:103866.57 (405.5%) stddev-sans-first:104127.19 14:54:50 INFO - PROCESS | 2643 | Values: 360.2 362.0 363.0 372.5 372.5 15725.8 20097.0 21193.5 21601.1 21617.5 19582.2 20300.4 21136.8 21143.6 21148.2 5557.9 5725.4 5739.5 5774.0 5796.0 4161.3 4440.8 5651.5 6323.6 6351.5 6155.8 6304.5 6311.4 6312.6 6342.7 6091.1 6217.0 6301.7 6310.0 6315.6 5405.6 5410.0 5430.4 5434.6 5439.4 25307.2 25917.9 26039.6 26138.7 26313.3 2161.1 2181.3 2220.5 2728.0 2838.5 14356.9 14885.4 14992.7 15022.2 15365.9 1741.3 1794.3 1804.6 1814.6 1827.0 79739.2 98353.0 99941.0 101507.0 102553.5 10144.7 10265.4 10477.8 10515.9 10589.4 10964.8 12973.9 13079.6 13083.2 13117.8 8348.8 8530.6 8627.0 8642.6 8803.0 8792.7 8799.0 8799.5 8895.6 8898.5 5972.6 6054.8 6069.2 6093.2 6131.1 1546.4 1673.7 1780.1 1791.8 1813.8 821.6 980.9 1012.5 1018.0 1027.7 17737.6 19390.8 19527.6 20612.8 21154.9 950.8 951.2 970.1 983.7 1019.9 8916.8 10996.4 11367.8 11381.3 11406.8 615535.0 620297.0 628038.8 644551.0 646457.0 79836.6 98293.0 98344.0 107157.0 107467.5 1022.6 1027.7 1031.1 1056.0 1058.7 18037.5 18270.1 18342.2 18489.8 18504.8 42964.4 44237.6 46572.0 47032.5 47240.0 53048.2 68497.0 68511.3 69845.0 70840.3 6194.8 7625.0 7629.0 7826.2 8001.5 12339.0 12375.6 12533.2 12738.7 12830.0 10782.5 10897.6 11284.3 11289.4 11314.5 10784.6 10785.7 10969.5 10991.1 11254.3 11283.5 11329.8 11344.2 11446.9 11534.8 6269.7 7654.1 7689.8 7745.7 7809.3 10939.2 11098.3 11347.8 11361.8 11403.0 14:54:50 INFO - PROCESS | 2643 | 14:54:50 INFO - PROCESS | 2643 | [#3] mootools.html Cycles:180 Average:6036.95 Median:529.38 stddev:3186.92 (602.0%) stddev-sans-first:3177.14 14:54:50 INFO - PROCESS | 2643 | Values: 1442.5 1577.9 1608.6 1850.8 1969.7 7938.8 8646.6 8773.9 8788.1 8798.6 8429.9 8664.0 8677.9 8685.8 8698.0 2161.9 2414.5 2460.2 2483.9 2493.9 2345.4 2458.7 2486.0 2491.9 2497.0 2425.5 2478.0 2506.9 2508.3 2509.2 2473.4 2493.6 2499.9 2517.3 2519.4 2461.0 2488.8 2499.2 2506.1 2506.8 8751.9 8796.0 8826.6 8845.9 8847.7 5372.8 5523.4 5528.9 5561.3 5562.9 3331.9 3449.1 3523.5 3698.6 3702.3 1046.9 1062.6 1067.1 1075.5 1081.9 11838.6 11850.5 11853.1 11856.2 11870.6 4771.7 4820.8 4889.6 4913.7 4925.9 10046.7 10047.0 10048.0 10061.9 10084.8 5481.0 5488.4 5524.2 5524.7 5527.2 4381.6 4533.8 4885.3 4957.5 4957.9 3790.5 3879.7 3884.7 3915.3 3938.7 1153.7 1292.5 1322.5 1329.9 1340.0 1354.2 1374.0 1395.1 1397.2 1400.3 7997.4 8174.7 8187.3 8188.1 8192.7 480.8 493.6 511.2 528.8 530.0 5862.9 6165.6 6216.6 6218.8 6223.3 10282.9 10713.6 10737.6 10826.2 10860.0 9382.6 10256.9 10261.9 10647.1 10664.4 8308.2 8328.9 8351.2 8400.1 8403.7 7797.1 7862.6 7873.1 7899.8 7922.1 9477.8 9530.4 9569.0 9570.6 9597.5 9754.7 9833.6 10009.3 10126.1 10129.3 6789.8 6869.8 7314.0 7487.4 7573.2 8233.2 8356.7 8360.7 8367.7 8370.4 7245.5 7368.8 7379.2 7497.9 7521.7 7150.2 7197.6 7218.6 7248.7 7348.7 7653.8 7737.3 7741.1 7742.8 7747.8 6950.1 6978.3 7027.2 7039.4 7045.5 7117.6 7194.0 7194.2 7213.8 7214.7 14:54:50 INFO - PROCESS | 2643 | 14:54:50 INFO - PROCESS | 2643 | [#4] prototype.html Cycles:180 Average:5674.15 Median:6506.67 stddev:1814.30 (27.9%) stddev-sans-first:1774.41 14:54:50 INFO - PROCESS | 2643 | Values: 325.1 328.4 332.3 335.3 337.3 5227.7 6489.6 6520.6 6570.6 6583.4 6488.6 6499.6 6506.3 6507.1 6541.9 4635.4 4736.5 4812.2 4874.1 4874.7 4816.6 4825.4 4847.2 4856.7 4859.9 3906.6 4246.7 4458.2 4767.7 4793.4 4592.2 4682.1 4768.0 4780.8 4783.5 4085.6 4091.8 4095.2 4096.0 4104.6 5103.3 6196.4 6221.5 6221.5 6251.5 4622.2 5601.2 5613.7 5624.1 5624.3 6843.6 6863.0 6866.7 6872.3 6880.6 4350.3 4534.4 4538.1 4547.6 4552.7 7177.0 7307.0 7316.1 7328.8 7330.4 4560.6 4561.9 4580.8 4581.2 4593.4 4637.7 4648.9 4651.5 4651.8 4664.4 5530.1 5530.7 5533.3 5542.1 5544.6 6659.8 6918.3 6942.6 6949.9 6959.0 1663.5 1675.5 1689.4 1690.7 1691.2 1030.4 1063.9 1089.6 1093.3 1116.2 6459.0 6604.3 6605.7 6625.0 6628.2 7260.6 7267.5 7270.0 7278.8 7281.4 6537.3 6542.9 6554.4 6555.5 6561.2 3795.8 3842.3 3845.6 3847.3 3848.7 7211.8 7488.1 7500.6 7502.6 7545.5 7444.3 7500.9 7502.2 7505.2 7514.1 7535.9 7541.8 7543.4 7546.6 7555.2 5046.9 6322.6 6843.5 7242.9 7269.7 7115.6 7129.7 7174.2 7175.4 7187.1 7528.5 7576.2 7595.5 7604.2 7608.9 4571.9 4624.3 4627.0 4632.8 4651.6 6936.6 7162.7 7193.1 7199.3 7213.4 6486.5 6882.6 6958.9 6979.1 7002.6 6903.2 6942.7 6942.8 6953.8 6958.7 6112.1 6275.3 6811.3 6811.6 6823.1 6666.9 6941.3 6945.3 6956.9 6957.6 6567.6 6719.6 6768.5 6794.7 6881.3 14:54:50 INFO - PROCESS | 2643 | 14:54:50 INFO - PROCESS | 2643 | [#5] yui.html Cycles:180 Average:18885.13 Median:634.53 stddev:26921.22 (4242.7%) stddev-sans-first:26962.12 14:54:50 INFO - PROCESS | 2643 | Values: 701.9 708.0 711.2 729.8 741.8 15050.5 17628.3 18009.5 18045.3 18069.2 16335.8 16440.8 16487.8 16523.9 16559.0 750.0 921.6 947.2 948.4 952.8 750.9 751.9 753.5 757.3 807.6 968.7 974.2 976.9 977.9 978.0 969.6 970.3 971.1 972.2 974.4 514.0 712.2 723.2 724.7 725.8 15378.6 15422.8 15456.1 15469.1 15485.6 10398.4 12303.5 12333.3 12432.9 12442.3 9839.2 9889.2 9953.0 9973.3 10226.9 3064.6 3415.6 3436.8 3495.2 3512.9 83940.0 85678.0 85680.6 85975.0 86756.7 9310.9 9448.7 9570.2 9661.8 9793.8 21400.8 21426.0 21456.4 21469.5 21474.9 7235.6 7370.1 7426.8 7434.7 7485.6 4081.2 4082.2 4163.1 4181.5 4281.1 3619.4 3678.1 3681.8 3690.9 3697.5 633.3 635.7 644.9 665.4 673.4 516.5 540.7 582.7 595.0 608.7 8215.5 8230.1 8235.6 8415.7 8425.7 536.8 594.5 618.2 622.6 629.0 3735.4 3776.2 3795.9 3807.5 4035.1 96857.5 97745.0 98514.0 101162.4 101242.5 78919.2 79718.8 82910.0 83939.7 85202.6 59432.4 72216.3 73313.0 74165.0 74505.0 7772.0 7782.7 7873.6 7886.8 7967.4 49265.8 51037.5 51605.0 51820.5 52295.5 56179.7 65179.3 70486.0 70612.0 72469.6 9904.1 9920.4 10895.9 11173.9 11383.7 11676.1 11925.9 12084.2 12299.7 12951.3 11185.0 11606.5 11638.7 11768.8 12098.5 10869.2 11184.7 11698.1 11915.8 11978.9 11273.1 11355.9 11458.5 11535.8 11730.7 9622.3 9669.2 9755.4 9933.0 10636.5 7695.4 8848.2 9167.3 9575.0 9761.0 14:54:50 INFO - PROCESS | 2643 | -------- Summary: end -------- 14:54:50 INFO - PROCESS | 2643 | 14:54:50 INFO - TEST-INFO | 2643: exit 0 14:54:50 INFO - TEST-OK | dromaeo_css | took 1113410ms 14:54:50 INFO - TEST-START | kraken 14:54:50 INFO - operating with platform_type : mac_ 14:54:50 INFO - Initialising browser for kraken test... 14:54:50 INFO - TEST-INFO | started process 2645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpNcRFZt/profile http://localhost:49741/getInfo.html) 14:54:52 INFO - PROCESS | 2645 | __metrics Screen width/height:1600/1200 14:54:52 INFO - PROCESS | 2645 | colorDepth:24 14:54:52 INFO - PROCESS | 2645 | Browser inner width/height: 1024/689 14:54:52 INFO - PROCESS | 2645 | __metrics 14:54:53 INFO - PROCESS | 2645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:54:53 ERROR - PROCESS | 2645 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:54:53 INFO - TEST-INFO | 2645: exit 0 14:54:53 INFO - Browser initialized. 14:54:53 INFO - Running cycle 1/1 for kraken test... 14:54:53 INFO - TEST-INFO | started process 2647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpNcRFZt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:55:05 INFO - PROCESS | 2647 | RSS: Main: 244187136 14:55:05 INFO - PROCESS | 2647 | 14:55:08 INFO - PROCESS | 2647 | Cycle 1(1): loaded http://localhost:49741/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49741/tests/kraken/driver.html?testName=audio-beat-detection) 14:55:08 INFO - PROCESS | 2647 | RSS: Main: 290455552 14:55:08 INFO - PROCESS | 2647 | 14:55:11 INFO - PROCESS | 2647 | Cycle 1(1): loaded http://localhost:49741/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49741/tests/kraken/driver.html?testName=audio-dft) 14:55:12 INFO - PROCESS | 2647 | RSS: Main: 300261376 14:55:12 INFO - PROCESS | 2647 | 14:55:15 INFO - PROCESS | 2647 | Cycle 1(1): loaded http://localhost:49741/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49741/tests/kraken/driver.html?testName=audio-fft) 14:55:16 INFO - PROCESS | 2647 | RSS: Main: 286789632 14:55:16 INFO - PROCESS | 2647 | 14:55:17 INFO - PROCESS | 2647 | Cycle 1(1): loaded http://localhost:49741/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49741/tests/kraken/driver.html?testName=audio-oscillator) 14:55:18 INFO - PROCESS | 2647 | RSS: Main: 288772096 14:55:18 INFO - PROCESS | 2647 | 14:55:20 INFO - PROCESS | 2647 | Cycle 1(1): loaded http://localhost:49741/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49741/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:55:21 INFO - PROCESS | 2647 | RSS: Main: 289812480 14:55:21 INFO - PROCESS | 2647 | 14:55:24 INFO - PROCESS | 2647 | Cycle 1(1): loaded http://localhost:49741/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49741/tests/kraken/driver.html?testName=imaging-darkroom) 14:55:24 INFO - PROCESS | 2647 | RSS: Main: 291160064 14:55:24 INFO - PROCESS | 2647 | 14:55:27 INFO - PROCESS | 2647 | Cycle 1(1): loaded http://localhost:49741/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49741/tests/kraken/driver.html?testName=imaging-desaturate) 14:55:28 INFO - PROCESS | 2647 | RSS: Main: 291581952 14:55:28 INFO - PROCESS | 2647 | 14:55:31 INFO - PROCESS | 2647 | Cycle 1(1): loaded http://localhost:49741/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49741/tests/kraken/driver.html?testName=json-parse-financial) 14:55:31 INFO - PROCESS | 2647 | RSS: Main: 291794944 14:55:31 INFO - PROCESS | 2647 | 14:55:33 INFO - PROCESS | 2647 | Cycle 1(1): loaded http://localhost:49741/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49741/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:55:33 INFO - PROCESS | 2647 | RSS: Main: 324886528 14:55:33 INFO - PROCESS | 2647 | 14:55:35 INFO - PROCESS | 2647 | Cycle 1(1): loaded http://localhost:49741/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49741/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:55:36 INFO - PROCESS | 2647 | RSS: Main: 325500928 14:55:36 INFO - PROCESS | 2647 | 14:55:38 INFO - PROCESS | 2647 | Cycle 1(1): loaded http://localhost:49741/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49741/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:55:39 INFO - PROCESS | 2647 | RSS: Main: 330981376 14:55:39 INFO - PROCESS | 2647 | 14:55:41 INFO - PROCESS | 2647 | Cycle 1(1): loaded http://localhost:49741/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49741/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:55:42 INFO - PROCESS | 2647 | RSS: Main: 331993088 14:55:42 INFO - PROCESS | 2647 | 14:55:45 INFO - PROCESS | 2647 | Cycle 1(1): loaded http://localhost:49741/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49741/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:55:45 INFO - PROCESS | 2647 | RSS: Main: 332034048 14:55:45 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | Cycle 1(1): loaded http://localhost:49741/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49741/tests/kraken/driver.html?testName=ai-astar) 14:55:47 INFO - PROCESS | 2647 | RSS: Main: 394551296 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | __start_tp_report 14:55:47 INFO - PROCESS | 2647 | _x_x_mozilla_page_load 14:55:47 INFO - PROCESS | 2647 | _x_x_mozilla_page_load_details 14:55:47 INFO - PROCESS | 2647 | |i|pagename|runs| 14:55:47 INFO - PROCESS | 2647 | |0;ai-astar;112;111;113;112;112;113;117;110;113;112 14:55:47 INFO - PROCESS | 2647 | |1;audio-beat-detection;156;124;145;163;118;142;140;121;162;125 14:55:47 INFO - PROCESS | 2647 | |2;audio-dft;186;186;188;188;187;183;183;183;183;184 14:55:47 INFO - PROCESS | 2647 | |3;audio-fft;80;72;84;79;55;58;56;76;77;48 14:55:47 INFO - PROCESS | 2647 | |4;audio-oscillator;93;99;134;81;78;85;117;80;79;119 14:55:47 INFO - PROCESS | 2647 | |5;imaging-gaussian-blur;89;89;134;129;91;89;134;130;91;86 14:55:47 INFO - PROCESS | 2647 | |6;imaging-darkroom;94;95;95;95;93;94;95;99;94;94 14:55:47 INFO - PROCESS | 2647 | |7;imaging-desaturate;87;110;144;139;85;84;87;85;87;88 14:55:47 INFO - PROCESS | 2647 | |8;json-parse-financial;53;56;55;54;55;54;54;66;56;54 14:55:47 INFO - PROCESS | 2647 | |9;json-stringify-tinderbox;64;65;79;76;70;69;69;70;71;70 14:55:47 INFO - PROCESS | 2647 | |10;stanford-crypto-aes;85;84;84;83;101;108;108;101;82;85 14:55:47 INFO - PROCESS | 2647 | |11;stanford-crypto-ccm;126;140;123;121;137;134;111;121;135;120 14:55:47 INFO - PROCESS | 2647 | |12;stanford-crypto-pbkdf2;139;164;180;139;140;130;141;140;137;141 14:55:47 INFO - PROCESS | 2647 | |13;stanford-crypto-sha256-iterative;69;66;67;68;68;68;68;67;66;67 14:55:47 INFO - PROCESS | 2647 | __end_tp_report 14:55:47 INFO - PROCESS | 2647 | __start_cc_report 14:55:47 INFO - PROCESS | 2647 | _x_x_mozilla_cycle_collect,1277 14:55:47 INFO - PROCESS | 2647 | __end_cc_report 14:55:47 INFO - PROCESS | 2647 | __startTimestamp1458942947562__endTimestamp 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | ------- Summary: start ------- 14:55:47 INFO - PROCESS | 2647 | Number of tests: 14 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.50 stddev:1.84 (1.6%) stddev-sans-first:1.94 14:55:47 INFO - PROCESS | 2647 | Values: 112.0 111.0 113.0 112.0 112.0 113.0 117.0 110.0 113.0 112.0 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:143.50 stddev:17.07 (11.9%) stddev-sans-first:17.04 14:55:47 INFO - PROCESS | 2647 | Values: 156.0 124.0 145.0 163.0 118.0 142.0 140.0 121.0 162.0 125.0 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | [#2] audio-dft Cycles:10 Average:185.10 Median:186.00 stddev:2.13 (1.1%) stddev-sans-first:2.24 14:55:47 INFO - PROCESS | 2647 | Values: 186.0 186.0 188.0 188.0 187.0 183.0 183.0 183.0 183.0 184.0 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | [#3] audio-fft Cycles:10 Average:68.50 Median:76.50 stddev:12.88 (16.8%) stddev-sans-first:12.97 14:55:47 INFO - PROCESS | 2647 | Values: 80.0 72.0 84.0 79.0 55.0 58.0 56.0 76.0 77.0 48.0 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:80.50 stddev:20.12 (25.0%) stddev-sans-first:21.30 14:55:47 INFO - PROCESS | 2647 | Values: 93.0 99.0 134.0 81.0 78.0 85.0 117.0 80.0 79.0 119.0 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | [#5] imaging-gaussian-blur Cycles:10 Average:106.20 Median:89.00 stddev:22.08 (24.8%) stddev-sans-first:22.53 14:55:47 INFO - PROCESS | 2647 | Values: 89.0 89.0 134.0 129.0 91.0 89.0 134.0 130.0 91.0 86.0 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:1.62 (1.7%) stddev-sans-first:1.69 14:55:47 INFO - PROCESS | 2647 | Values: 94.0 95.0 95.0 95.0 93.0 94.0 95.0 99.0 94.0 94.0 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | [#7] imaging-desaturate Cycles:10 Average:99.60 Median:86.00 stddev:23.36 (27.2%) stddev-sans-first:24.33 14:55:47 INFO - PROCESS | 2647 | Values: 87.0 110.0 144.0 139.0 85.0 84.0 87.0 85.0 87.0 88.0 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:3.74 (6.8%) stddev-sans-first:3.84 14:55:47 INFO - PROCESS | 2647 | Values: 53.0 56.0 55.0 54.0 55.0 54.0 54.0 66.0 56.0 54.0 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.00 stddev:4.47 (6.4%) stddev-sans-first:4.12 14:55:47 INFO - PROCESS | 2647 | Values: 64.0 65.0 79.0 76.0 70.0 69.0 69.0 70.0 71.0 70.0 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | [#10] stanford-crypto-aes Cycles:10 Average:92.10 Median:83.50 stddev:10.96 (13.1%) stddev-sans-first:11.32 14:55:47 INFO - PROCESS | 2647 | Values: 85.0 84.0 84.0 83.0 101.0 108.0 108.0 101.0 82.0 85.0 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:130.00 stddev:9.28 (7.1%) stddev-sans-first:9.84 14:55:47 INFO - PROCESS | 2647 | Values: 126.0 140.0 123.0 121.0 137.0 134.0 111.0 121.0 135.0 120.0 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.10 Median:140.50 stddev:15.01 (10.7%) stddev-sans-first:15.76 14:55:47 INFO - PROCESS | 2647 | Values: 139.0 164.0 180.0 139.0 140.0 130.0 141.0 140.0 137.0 141.0 14:55:47 INFO - PROCESS | 2647 | 14:55:47 INFO - PROCESS | 2647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:0.83 14:55:47 INFO - PROCESS | 2647 | Values: 69.0 66.0 67.0 68.0 68.0 68.0 68.0 67.0 66.0 67.0 14:55:47 INFO - PROCESS | 2647 | -------- Summary: end -------- 14:55:47 INFO - PROCESS | 2647 | 14:55:48 INFO - TEST-INFO | 2647: exit 0 14:55:48 INFO - TEST-OK | kraken | took 57695ms 14:55:48 INFO - SUITE-END | took 1171s 14:55:48 INFO - Completed test suite (00:19:31) 14:55:48 INFO - javascript benchmark 14:55:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3374.9156271093225, 3413.6245013048547, 3439.8108104054268, 3457.4468085106373, 3508.4035713928647, 5559.749811258493, 5577.107662773957, 5600.523955463786, 5625.5499560035205, 5631.155326701002, 5654.264945557082, 5668.68822214778, 5686.1186516089965, 5773.249477567911, 5786.0, 5089.770960306777, 5099.872503187422, 5131.281620573104, 5149.845504634848, 5208.713520756357, 5220.556252718524, 5226.634135610509, 5260.447652996438, 5273.156294992802, 5307.150855863063, 5060.822871199527, 5087.66930149541, 5173.224016397533, 5174.689518628894, 5211.817586384496, 5163.302954101186, 5165.948340516585, 5176.55999240065, 5195.272661827347, 5217.5565076968505, 5100.821471248526, 5122.282880396748, 5144.305518754958, 5165.276861239429, 5191.325127733408, 5478.561715062825, 5558.583106267046, 5605.775768969236, 5610.410906854803, 5668.801591944303, 6163.1679723237685, 6164.784232551884, 6169.9383006170265, 6170.814875553696, 6175.228096487939, 6196.721147548371, 6226.315105338409, 6243.0, 6263.624182549016, 6268.341824108448, 4779.880502987384, 5600.187972743929, 5679.602427830012, 5725.370209277018, 5753.108268218432, 6335.239771227482, 6361.745530178741, 6364.363563643691, 6378.266499352541, 6387.233531976192, 5965.433283838029, 5976.432238937294, 6019.006863867413, 6022.2171117754415, 6040.275166979991, 6068.969655151696, 6106.877862442726, 6125.021800333839, 6160.44555989963, 6165.537584681167, 6083.148359229712, 6084.775645005126, 6109.647596799064, 6112.989854784112, 6132.386761323832, 6143.815685529352, 6145.4161854623735, 6150.600210986271, 6154.661493617805, 6155.630662160284, 4689.577937985529, 4705.200115980291, 4760.690555113906, 4763.54746299101, 4764.6664733469015, 4385.386045953569, 4420.845270415584, 4421.29259318514, 4422.690411671217, 4435.534268901783, 5537.8061767837935, 5591.133374326986, 5595.356533998643, 5595.636283641632, 5634.943650563442, 6115.909724157157, 6126.120738204466, 6127.433875357673, 6239.75040998355, 6277.24673039229, 4689.742064186435, 5587.497125258747, 5600.607957443021, 5601.103823388238, 5626.606137570413, 5291.365036195682, 5294.047071527085, 5300.973495132577, 5305.734713264322, 5341.332333458317, 6242.157308763259, 6269.62382257066, 6341.270753863272, 6352.460040896575, 6385.0, 6182.1345011697495, 6209.751609935552, 6212.285587157535, 6217.4715149212825, 6226.657533835682, 6209.59637623553, 6338.0, 6367.586106903036, 6369.1401660777055, 6380.968095159495, 6000.399960003964, 6078.756849725962, 6096.466212027279, 6098.91636565712, 6110.103144028831, 6180.783672571618, 6191.473724733448, 6211.565190436807, 6212.285587157354, 6217.626942383471, 5849.298084229919, 5865.970670146793, 5917.822465326047, 5947.732352044082, 5948.196993405835, 5963.9105413417965, 5977.671228082497, 5979.760809567569, 6002.7298771554515, 6023.247094113236, 4855.34452848875, 5810.448007439287, 5852.122181672613, 5855.38518455556, 5874.0, 5491.615586909038, 5589.832305030855, 5733.556493717402, 5943.791967281124, 6067.362926892612, 5874.030784920611, 5875.294964604275, 5890.204822349099, 5890.646561206341, 5934.43622855828], "unit": "score", "name": "dojo.html", "value": 5622.791585139593}, {"lowerIsBetter": false, "replicates": [487.7561219390305, 542.9185622156676, 569.9029368465705, 628.0798630007039, 636.0745115856429, 38265.0, 38809.0, 38834.80582597086, 38866.99999999996, 38912.027199319964, 41797.58202417975, 42181.578184218146, 42272.0, 42321.0, 42386.15227695444, 8266.669333226664, 8276.83446331073, 9373.76565585859, 9587.328886977879, 9589.712308630717, 9559.617615295414, 9722.756931076745, 9734.610615575368, 9738.561764720605, 9741.17200037994, 9684.467354295512, 9755.707328780149, 9760.560774765152, 9766.316357854954, 9774.511274436285, 9655.951720241388, 9735.221182305399, 9748.171405430512, 9772.31593788435, 9798.265130115198, 9445.149936505679, 9496.0, 9666.565004574812, 9670.75823104428, 9681.322307438482, 40381.990450238685, 40728.59271407278, 40814.0, 40817.387739183934, 40841.387379189335, 3235.773495855291, 3255.462848629973, 3271.188038726264, 3274.607047154333, 3491.6159222485508, 28643.57034644482, 28836.423271534662, 29099.0, 29118.0, 29965.850170749225, 2708.986455067712, 2861.570764385338, 2899.2027192522014, 2899.5070837957596, 2900.9274768130754, 494980.0, 498281.5085924583, 499146.0, 499186.0, 499801.0, 61143.388566114656, 63158.68420657867, 63398.68300658467, 63454.68272658607, 63515.87146835441, 66280.00579991304, 66285.0, 66661.0, 66695.33304666891, 66816.0, 16838.073905935293, 17065.402710905306, 17077.12151663316, 17083.743743843603, 17108.48674539766, 13029.413676384585, 13138.868611313956, 13142.0, 13143.211407315592, 13189.934050329686, 17979.345938965067, 18939.0, 19357.322493712654, 19405.611887762167, 19492.512687182934, 6380.55336126476, 6965.547239429522, 7070.797964346074, 7735.1491335953, 7812.843743125106, 915.4278575890069, 963.4219468318953, 996.9152622027063, 1010.4745532323298, 1107.5735841701003, 27877.0, 28441.57337639937, 28555.857220713762, 28591.714082859322, 28612.0, 1010.701842956315, 1064.4677661169414, 1185.875483074282, 1214.979417289481, 1234.9444275007647, 14860.479883204036, 14882.69318255672, 14923.403063877324, 15184.392624295126, 15230.46693365727, 521623.0, 525969.0, 527331.0, 527441.0, 529680.0, 59122.11316830251, 59374.40625593689, 59396.7030164855, 59501.0, 59597.404025959186, 1318.4528420705492, 1438.1155589312707, 1447.5946734914241, 1456.4538298138198, 1478.046659904377, 28099.859500702365, 28690.56964145581, 29232.70767292385, 29298.707012929597, 29529.704702953553, 44288.0, 46289.53710462987, 47026.76486617545, 47152.0, 47233.0, 362338.0, 366108.0, 366253.0, 366259.0, 366540.0, 28040.719592804628, 32017.199570010936, 32504.512432314008, 33127.0, 33785.49321760225, 41101.17797643971, 42013.0, 42051.57948420477, 42094.57905420907, 42796.78601607097, 31400.0, 32178.35643287168, 33868.0, 34646.0, 35243.0, 34137.0, 34138.14654633654, 34727.82636086905, 34772.47841282332, 35009.64990350064, 34945.47581786326, 35251.0, 35603.10992225215, 35934.92195234147, 35986.64013359938, 26850.32874178161, 30525.084247472612, 31695.683043169272, 31711.524327135572, 31858.362832743678, 23596.764032359457, 23827.285181444586, 23839.756237668134, 23917.40206494782, 24041.398965026016], "unit": "score", "name": "ext.html", "value": 19399.788950218895}, {"lowerIsBetter": false, "replicates": [360.22012343276805, 361.9764715293506, 362.9546306711661, 372.4692313453332, 372.54363404829087, 15725.84274157258, 20096.995150242485, 21193.470163245926, 21601.1359545618, 21617.45956351092, 19582.216711331566, 20300.390988270374, 21136.788632113676, 21143.577128457422, 21148.154073837068, 5557.944420555803, 5725.398833122525, 5739.540836733072, 5774.0, 5796.0, 4161.292580261348, 4440.777961101932, 5651.491365777079, 6323.620582765026, 6351.460125889305, 6155.846103847417, 6304.495640348784, 6311.368863113697, 6312.558120931537, 6342.682865856688, 6091.0863370494335, 6217.036359364283, 6301.6534090625, 6310.0, 6315.589486683374, 5405.621606487547, 5409.972950135263, 5430.402655707869, 5434.565234781247, 5439.428859969726, 25307.240782776546, 25917.870410647825, 26039.609405858737, 26138.73861261382, 26313.3421664458, 2161.103142195987, 2181.2801775414077, 2220.455988282881, 2728.0, 2838.5316422790215, 14356.928215358856, 14885.404583816635, 14992.70014599702, 15022.173780442072, 15365.923170384189, 1741.3469948769211, 1794.3450640516248, 1804.639072185555, 1814.5645045189192, 1827.044448768415, 79739.20260797376, 98353.0, 99941.0, 101507.0, 102553.48723256336, 10144.746381340377, 10265.435401052864, 10477.84283235752, 10515.894841051644, 10589.364638121737, 10964.780704385868, 12973.924172132414, 13079.607611771662, 13083.215007099605, 13117.803232951514, 8348.791280217922, 8530.616122274512, 8627.0, 8642.611082501302, 8802.955985220033, 8792.736217913473, 8799.032106468283, 8799.516026618598, 8895.555222238861, 8898.4660920345, 5972.552058595623, 6054.8183554493435, 6069.180660610849, 6093.238345206849, 6131.14164017038, 1546.3505327762366, 1673.6987342278508, 1780.1188411736014, 1791.7939436964655, 1813.7642106526066, 821.6138414944967, 980.8670985012322, 1012.5089331674133, 1017.9694609161737, 1027.6968294353185, 17737.645247094984, 19390.8060919389, 19527.60944781125, 20612.793872061087, 21154.894225528773, 950.8050849575959, 951.2437612098398, 970.1414248390084, 983.6606370802061, 1019.8521214423866, 8916.777080573038, 10996.350547417791, 11367.772644547063, 11381.317120972768, 11406.828897566544, 615535.0, 620297.0, 628038.756899447, 644551.0, 646457.0, 79836.60898650513, 98293.0, 98344.0, 107157.0, 107467.46266268619, 1022.5807418958192, 1027.7225149209671, 1031.0514326819193, 1055.994720026395, 1058.730023843915, 18037.549061273574, 18270.086495674896, 18342.17460214267, 18489.81510184881, 18504.81495185031, 42964.35553466638, 44237.55762442463, 46572.0, 47032.52967470281, 47240.0, 53048.204276936645, 68497.0, 68511.31488685249, 69845.0, 70840.29159708337, 6194.787107043303, 7624.961875190588, 7629.046369203849, 7826.2173782621285, 8001.479903806234, 12339.0, 12375.648626760887, 12533.185342952678, 12738.745225095261, 12829.973602111995, 10782.514786834454, 10897.618583349546, 11284.32294062359, 11289.435528223721, 11314.490847911698, 10784.622538211124, 10785.73035674083, 10969.464275001666, 10991.06575941022, 11254.268472549258, 11283.492242848928, 11329.773404531697, 11344.20590558686, 11446.94276528612, 11534.82697759551, 6269.717862696099, 7654.119776225805, 7689.807754806175, 7745.728899488491, 7809.258120478546, 10939.179561533076, 11098.334099954029, 11347.773044539228, 11361.772764544497, 11403.0], "unit": "score", "name": "jquery.html", "value": 9453.328914447326}, {"lowerIsBetter": false, "replicates": [1442.5239670908602, 1577.8797054091594, 1608.5576466471723, 1850.8056654051325, 1969.675003624402, 7938.761837144888, 8646.567671616418, 8773.912260877389, 8788.077251888555, 8798.604062817172, 8429.91570084299, 8663.956680216606, 8677.869831952527, 8685.782855428617, 8698.043215246318, 2161.945951351213, 2414.4929564791414, 2460.1635443949053, 2483.863387513686, 2493.8628375439343, 2345.3901985483726, 2458.6926634170727, 2485.9751402485927, 2491.9127830525936, 2497.0386401235473, 2425.463896031692, 2477.9876100619563, 2506.862122583257, 2508.3227528567277, 2509.2095989763257, 2473.4311108445067, 2493.5760920643443, 2499.8875050622673, 2517.332906779705, 2519.44572194117, 2460.963085553718, 2488.8008959283393, 2499.225240175533, 2506.0852788732163, 2506.8119891008246, 8751.912480875173, 8796.032436432051, 8826.602802873886, 8845.911540884637, 8847.73456796297, 5372.758225879845, 5523.392426833045, 5528.944710552923, 5561.277033985596, 5562.86092847678, 3331.933361332784, 3449.137715571107, 3523.541939547868, 3698.593154752975, 3702.2595480903656, 1046.905778479933, 1062.6440142552176, 1067.0983019348637, 1075.4783929794044, 1081.874850155837, 11838.644840654793, 11850.466728997217, 11853.111016673784, 11856.170068095236, 11870.584529541511, 4771.66598338113, 4820.807167713322, 4889.604093993918, 4913.680610760289, 4925.9014819704125, 10046.69859904204, 10047.0, 10048.045435683598, 10061.949690251648, 10084.848727269096, 5481.040817856859, 5488.396276409591, 5524.1989911462615, 5524.696141712245, 5527.198556209327, 4381.605655491021, 4533.77331133442, 4885.340479035356, 4957.529034741694, 4957.900841983213, 3790.469334293201, 3879.689624830007, 3884.6892248620043, 3915.334393153171, 3938.7439816411843, 1153.7424207613574, 1292.4894666606638, 1322.5238913990956, 1329.9069065165345, 1339.9866001339863, 1354.1942544186193, 1374.0450386980951, 1395.0722769358465, 1397.2385050147693, 1400.3138462153472, 7997.400194985399, 8174.713885013996, 8187.304079153219, 8188.099309075997, 8192.713255036046, 480.7908111100585, 493.56812788809793, 511.2382550000473, 528.801699362739, 529.9655522391032, 5862.912056319158, 6165.599236049642, 6216.595921265103, 6218.81343559694, 6223.253209614875, 10282.897171028193, 10713.625023124308, 10737.550430691912, 10826.18803589734, 10860.0, 9382.577783999737, 10256.948715256376, 10261.897381026243, 10647.094996925349, 10664.360138391567, 8308.169183081643, 8328.875066874001, 8351.206635369508, 8400.117987611213, 8403.663853445916, 7797.142314345304, 7862.567558784322, 7873.055233372032, 7899.84200315979, 7922.0889597697005, 9477.810443791224, 9530.428174309563, 9569.0, 9570.61717531291, 9597.47213903242, 9754.658586949707, 9833.60665573369, 10009.299349045788, 10126.13927816144, 10129.341592796445, 6789.830254243683, 6869.828254293682, 7313.963430182815, 7487.438442116754, 7573.166951635206, 8233.217844304781, 8356.749297521084, 8360.749177524684, 8367.748967530984, 8370.37222208349, 7245.529040612343, 7368.815779605553, 7379.188289288067, 7497.850042999218, 7521.736739214101, 7150.177729561167, 7197.640117993975, 7218.602976836324, 7248.710051597877, 7348.742794002184, 7653.846923061396, 7737.3423259021365, 7741.07107147146, 7742.7677169685, 7747.806304842424, 6950.131233595801, 6978.337057979484, 7027.15674119109, 7039.436845052486, 7045.506814522934, 7117.6085315308155, 7193.964030179815, 7194.244604316681, 7213.819654508469, 7214.74748383804], "unit": "score", "name": "mootools.html", "value": 4849.028776297029}, {"lowerIsBetter": false, "replicates": [325.07840272826536, 328.3891960952628, 332.2590622910907, 335.27580426279235, 337.28327304477966, 5227.660202086861, 6489.578177418471, 6520.576162549431, 6570.572912760673, 6583.440407565363, 6488.610683359002, 6499.577527460712, 6506.284308726036, 6507.05647681086, 6541.934580654192, 4635.374224479702, 4736.4789873114105, 4812.23004319309, 4874.098291816025, 4874.6831455955335, 4816.638752093607, 4825.420949486067, 4847.248676455155, 4856.68431551948, 4859.902801943959, 3906.570277269498, 4246.723962942414, 4458.242098843189, 4767.713937163781, 4793.3528973588645, 4592.173408786417, 4682.1338052460405, 4768.046390721869, 4780.760961951889, 4783.4977327380475, 4085.5914408558906, 4091.7954102294766, 4095.1604920991126, 4096.0, 4104.610062044101, 5103.260027296058, 6196.380361963767, 6221.502279817604, 6221.5333849961435, 6251.531135164881, 4622.214223581999, 5601.243832082698, 5613.719314034322, 5624.100143976944, 5624.268845050117, 6843.62360070196, 6862.965685171592, 6866.690998905061, 6872.278410766898, 6880.552764070319, 4350.347447882811, 4534.38785763921, 4538.137753826795, 4547.567981041796, 4552.749598772066, 7177.021536062528, 7306.963465182694, 7316.122065352139, 7328.78013659591, 7330.413566914634, 4560.566746159109, 4561.908761824745, 4580.8167673293365, 4581.198290299184, 4593.379893714306, 4637.698549594265, 4648.930266046012, 4651.488336283006, 4651.837185698552, 4664.370310008173, 5530.11518157101, 5530.723463826793, 5533.280673512418, 5542.140968149944, 5544.556435485151, 6659.766908158192, 6918.308169183142, 6942.618156001367, 6949.861002779916, 6959.0, 1663.4593757028772, 1675.4973507947566, 1689.4340395967488, 1690.653416049707, 1691.196681576266, 1030.407515678488, 1063.8670166229222, 1089.5641743302742, 1093.2729734726317, 1116.2465335898398, 6459.0, 6604.306547812506, 6605.669716514155, 6624.96687516569, 6628.171478565179, 7260.6006669632625, 7267.527610705287, 7269.963650181715, 7278.781636550912, 7281.381082608038, 6537.280899101095, 6542.934570654233, 6554.442872355903, 6555.541112122201, 6561.179852518435, 3795.772253664789, 3842.289176502356, 3845.576986531479, 3847.3074846527893, 3848.6728628066367, 7211.819704507429, 7488.063992001, 7500.58746768922, 7502.624868756649, 7545.547267163988, 7444.292792184734, 7500.912367706652, 7502.17476077631, 7505.174430812606, 7514.135874374517, 7535.886961695579, 7541.849163016709, 7543.434242431839, 7546.622668866535, 7555.16893141743, 5046.949530504648, 6322.620642761449, 6843.520953533205, 7242.927570724225, 7269.672864720995, 7115.5730656160795, 7129.714811407693, 7174.210836808052, 7175.354218120394, 7187.137543494814, 7528.548287102792, 7576.181716387917, 7595.506292091218, 7604.163542010485, 7608.923910760822, 4571.862844114682, 4624.28323609841, 4626.976865115653, 4632.7954731769305, 4651.5813576778255, 6936.583804971718, 7162.7493037743425, 7193.064901562972, 7199.280071992759, 7213.3868621167785, 6486.54594178403, 6882.621455819978, 6958.921367188094, 6979.092717946634, 7002.649867506706, 6903.1716194055025, 6942.652867356713, 6942.757003504853, 6953.826154346182, 6958.686859091455, 6112.144299797943, 6275.309715931153, 6811.318868113149, 6811.625360605214, 6823.089534930029, 6666.866662666816, 6941.34057264559, 6945.305469453217, 6956.860862782817, 6957.582545047313, 6567.605943643397, 6719.563228390139, 6768.492363072888, 6794.660266986532, 6881.311868813079], "unit": "score", "name": "prototype.html", "value": 5076.632837117027}, {"lowerIsBetter": false, "replicates": [701.9227884932658, 708.022928358865, 711.2460791560943, 729.824842037911, 741.762635956494, 15050.548483545497, 17628.294868205274, 18009.459716208534, 18045.278188872464, 18069.186886590087, 16335.83664163358, 16440.75338869918, 16487.83512164878, 16523.91738041308, 16559.006459612432, 749.9850002999937, 921.6221349246811, 947.199616324205, 948.4025064209573, 952.8475443928972, 750.9173990861001, 751.8533885892253, 753.5328096580128, 757.3221966340122, 807.5800583696474, 968.6706519783272, 974.2449601558777, 976.8534719792017, 977.9022097790236, 977.9559919803626, 969.5636963366478, 970.2868391732071, 971.0774763974182, 972.2416515118219, 974.3666616699131, 513.9820106296299, 712.2130046298817, 723.222535774045, 724.7427163356986, 725.8366867454833, 15378.615534611725, 15422.845771542365, 15456.149911754848, 15469.071855688582, 15485.612859678486, 10398.428086455242, 12303.507859685602, 12333.260004399765, 12432.875671243262, 12442.253464792051, 9839.212862970946, 9889.20886329092, 9952.950235248778, 9973.252006099572, 10226.948865255627, 3064.5709600655928, 3415.624281329052, 3436.7937923724407, 3495.2485215678753, 3512.8594856205978, 83940.0, 85678.0, 85680.57159714223, 85975.0, 86756.6986495203, 9310.882694076754, 9448.669296574586, 9570.186534144676, 9661.806763864683, 9793.804123917482, 21400.82295473764, 21426.03582838776, 21456.356309310744, 21469.46326341854, 21474.892625536773, 7235.6020418876415, 7370.078740157481, 7426.760577371989, 7434.73978410753, 7485.625718714152, 4081.2041651878194, 4082.2243773682903, 4163.10493243954, 4181.498220213593, 4281.05816720321, 3619.4027985382645, 3678.0988657779017, 3681.7606855554304, 3690.9261814763554, 3697.482352470656, 633.338161621107, 635.7139287320724, 644.861354808709, 665.411111166621, 673.4174938678008, 516.4551398274781, 540.6701911833857, 582.6911736779514, 594.9732262048218, 608.716946619824, 8215.548144852091, 8230.135835737161, 8235.629396677165, 8415.70545030921, 8425.662973481114, 536.8389483155038, 594.5184400635499, 618.2210414877197, 622.5548732656173, 628.9967501834567, 3735.364987952055, 3776.2258736958856, 3795.9240815183543, 3807.466954626299, 4035.051762835731, 96857.51571242098, 97745.0, 98514.02971940664, 101162.42444241101, 101242.49378753059, 78919.21080789233, 79718.80421793678, 82910.0, 83939.74090388649, 85202.57398712967, 59432.405675943555, 72216.277837222, 73313.0, 74165.0, 74505.0, 7771.961140194489, 7782.688692452239, 7873.606319684108, 7886.802829929297, 7967.402444816546, 49265.75367123142, 51037.48962510328, 51605.0, 51820.481795181564, 52295.47704523058, 56179.71910140423, 65179.34820651922, 70486.0, 70612.0, 72469.6376518114, 9904.108630223314, 9920.355176913477, 10895.891041089488, 11173.944130279297, 11383.684116206223, 11676.124290678063, 11925.926666600048, 12084.154109212272, 12299.69250768738, 12951.287679177736, 11185.049270812073, 11606.477708503306, 11638.6508404748, 11768.764624707286, 12098.455569499569, 10869.239153259196, 11184.720381990515, 11698.122640801803, 11915.761684766083, 11978.880211198126, 11273.098152147972, 11355.886441135814, 11458.541658333574, 11535.779743405701, 11730.70673233176, 9622.278329125204, 9669.226461883172, 9755.365901216399, 9932.950335248277, 10636.52135653882, 7695.384369250559, 8848.247898928663, 9167.312451566293, 9574.95212523933, 9761.0], "unit": "score", "name": "yui.html", "value": 6967.427164930108}], "name": "dromaeo_css", "value": 7492.245273259687}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 113.0, 112.0, 112.0, 113.0, 117.0, 110.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [156.0, 124.0, 145.0, 163.0, 118.0, 142.0, 140.0, 121.0, 162.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 139.6}, {"lowerIsBetter": true, "replicates": [186.0, 186.0, 188.0, 188.0, 187.0, 183.0, 183.0, 183.0, 183.0, 184.0], "unit": "score", "name": "audio-dft", "value": 185.1}, {"lowerIsBetter": true, "replicates": [80.0, 72.0, 84.0, 79.0, 55.0, 58.0, 56.0, 76.0, 77.0, 48.0], "unit": "score", "name": "audio-fft", "value": 68.5}, {"lowerIsBetter": true, "replicates": [93.0, 99.0, 134.0, 81.0, 78.0, 85.0, 117.0, 80.0, 79.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 96.5}, {"lowerIsBetter": true, "replicates": [89.0, 89.0, 134.0, 129.0, 91.0, 89.0, 134.0, 130.0, 91.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 106.2}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 95.0, 95.0, 93.0, 94.0, 95.0, 99.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.8}, {"lowerIsBetter": true, "replicates": [87.0, 110.0, 144.0, 139.0, 85.0, 84.0, 87.0, 85.0, 87.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 99.6}, {"lowerIsBetter": true, "replicates": [53.0, 56.0, 55.0, 54.0, 55.0, 54.0, 54.0, 66.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 79.0, 76.0, 70.0, 69.0, 69.0, 70.0, 71.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.3}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 84.0, 83.0, 101.0, 108.0, 108.0, 101.0, 82.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 92.1}, {"lowerIsBetter": true, "replicates": [126.0, 140.0, 123.0, 121.0, 137.0, 134.0, 111.0, 121.0, 135.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.8}, {"lowerIsBetter": true, "replicates": [139.0, 164.0, 180.0, 139.0, 140.0, 130.0, 141.0, 140.0, 137.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.1}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1460.2}]} 14:55:48 INFO - Return code: 0 14:55:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:55:48 ERROR - # TBPL SUCCESS # 14:55:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:55:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:55:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:55:48 INFO - 2016-03-25 14:55:48.880 screenresolution[2651:19380] starting screenresolution argv=screenresolution get 14:55:48 INFO - 2016-03-25 14:55:48.882 screenresolution[2651:19380] Display 0: 1600x1200x32@60 14:55:48 INFO - 2016-03-25 14:55:48.888 screenresolution[2652:19383] starting screenresolution argv=screenresolution list 14:55:48 INFO - Available Modes on Display 0 14:55:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:55:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:55:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:55:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:55:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:55:49 INFO - Intel Iris: 14:55:49 INFO - Chipset Model: Intel Iris 14:55:49 INFO - Type: GPU 14:55:49 INFO - Bus: Built-In 14:55:49 INFO - VRAM (Dynamic, Max): 1536 MB 14:55:49 INFO - Vendor: Intel (0x8086) 14:55:49 INFO - Device ID: 0x0a2e 14:55:49 INFO - Revision ID: 0x0009 14:55:49 INFO - Displays: 14:55:49 INFO - Display: 14:55:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:55:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:55:49 INFO - Display Serial Number: 1600x1200 60 14:55:49 INFO - Main Display: Yes 14:55:49 INFO - Mirror: Off 14:55:49 INFO - Online: Yes 14:55:49 INFO - Rotation: Supported 14:55:49 INFO - Return code: 0 14:55:49 INFO - Running post-action listener: _resource_record_post_action 14:55:49 INFO - Running post-run listener: _resource_record_post_run 14:55:50 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 126976; Write bytes: 702267904; Read time: 2; Write time: 2115 14:55:50 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389749248; Write bytes: 383788544; Read time: 29577; Write time: 688 14:55:50 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 126976; Write bytes: 296954880; Read time: 2; Write time: 1379 14:55:50 INFO - Running post-run listener: _upload_blobber_files 14:55:50 INFO - Blob upload gear active. 14:55:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:55:50 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 14:55:50 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'] 14:55:50 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 14:55:50 INFO - (blobuploader) - INFO - Open directory for files ... 14:55:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:55:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:55:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:51 INFO - (blobuploader) - INFO - Done attempting. 14:55:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:55:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:55:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:52 INFO - (blobuploader) - INFO - Done attempting. 14:55:52 INFO - (blobuploader) - INFO - Iteration through files over. 14:55:52 INFO - Return code: 0 14:55:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:55:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:55:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc0c741dfa8be59c5fdde164070cf31a6c5fd5b4a6194b5875fd795ef7e22205444c3503e382b7d0af93710bc8cfa3e0bfc93096400533bd23812887f164f48b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2ecec670f6fec3c330f347469b9363dc542c41f2cb33f2444b15e90c1e00c1f9f2e50fa3d456f444540c26fe21e4be00630bb0cc873f19ed753bb8ba8da47b7"} 14:55:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:55:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:55:52 INFO - Contents: 14:55:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc0c741dfa8be59c5fdde164070cf31a6c5fd5b4a6194b5875fd795ef7e22205444c3503e382b7d0af93710bc8cfa3e0bfc93096400533bd23812887f164f48b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2ecec670f6fec3c330f347469b9363dc542c41f2cb33f2444b15e90c1e00c1f9f2e50fa3d456f444540c26fe21e4be00630bb0cc873f19ed753bb8ba8da47b7"} 14:55:52 INFO - Running post-run listener: copy_logs_to_upload_dir 14:55:52 INFO - Copying logs to upload dir... 14:55:52 INFO - mkdir: /builds/slave/test/build/upload/logs 14:55:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.188529 ========= master_lag: 11.97 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-03-25 14:56:04.246335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-03-25 14:56:04.250868) ========= 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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc0c741dfa8be59c5fdde164070cf31a6c5fd5b4a6194b5875fd795ef7e22205444c3503e382b7d0af93710bc8cfa3e0bfc93096400533bd23812887f164f48b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2ecec670f6fec3c330f347469b9363dc542c41f2cb33f2444b15e90c1e00c1f9f2e50fa3d456f444540c26fe21e4be00630bb0cc873f19ed753bb8ba8da47b7"} build_url:https://queue.taskcluster.net/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/ZZAwb2AzT-CvMpE4PMgbBw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc0c741dfa8be59c5fdde164070cf31a6c5fd5b4a6194b5875fd795ef7e22205444c3503e382b7d0af93710bc8cfa3e0bfc93096400533bd23812887f164f48b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2ecec670f6fec3c330f347469b9363dc542c41f2cb33f2444b15e90c1e00c1f9f2e50fa3d456f444540c26fe21e4be00630bb0cc873f19ed753bb8ba8da47b7"}' ========= master_lag: 4.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-03-25 14:56:08.289606) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-03-25 14:56:08.289931) ========= 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.bjwIXlBL3Q/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.hPC4BGTfzz/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.005421 ========= master_lag: 5.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-03-25 14:56:13.586716) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 14:56:13.587034) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 14:56:14.123233) ========= ========= Total master_lag: 24.94 =========