builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0190 starttime: 1457963341.07 results: success (0) buildid: 20160314051529 builduid: b000b69c79c6480397a4509f0a0e30e5 revision: 2bef59a4476a99e0796bde9502c1bf0744f97182 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:01.073449) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:01.074046) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:01.074363) ========= 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.qRbet5Vm6v/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.YWknkLGiJB/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.005520 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:01.154961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:01.155338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:01.185992) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:01.186353) ========= 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.qRbet5Vm6v/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.YWknkLGiJB/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.004908 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:01.266007) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:01.266333) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:01.266720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:01.267205) ========= 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.qRbet5Vm6v/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.YWknkLGiJB/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-14 06:49:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.3M=0.001s 2016-03-14 06:49:01 (16.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136358 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:01.444416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:01.444703) ========= 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.qRbet5Vm6v/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.YWknkLGiJB/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.026908 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:01.547495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 06:49:01.550848) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2bef59a4476a99e0796bde9502c1bf0744f97182 --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 2bef59a4476a99e0796bde9502c1bf0744f97182 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qRbet5Vm6v/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.YWknkLGiJB/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-14 06:49:01,624 truncating revision to first 12 chars 2016-03-14 06:49:01,624 Setting DEBUG logging. 2016-03-14 06:49:01,624 attempt 1/10 2016-03-14 06:49:01,624 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2bef59a4476a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 06:49:02,710 unpacking tar archive at: fx-team-2bef59a4476a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331906 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 06:49:02.900220) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:02.900556) ========= echo 2bef59a4476a99e0796bde9502c1bf0744f97182 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2bef59a4476a99e0796bde9502c1bf0744f97182'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qRbet5Vm6v/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.YWknkLGiJB/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 2bef59a4476a99e0796bde9502c1bf0744f97182 program finished with exit code 0 elapsedTime=0.005489 script_repo_revision: '2bef59a4476a99e0796bde9502c1bf0744f97182' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:02.956592) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:02.956962) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 06:49:02.973673) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-03-14 06:49:02.974039) ========= /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.qRbet5Vm6v/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.YWknkLGiJB/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 06:49:03 INFO - MultiFileLogger online at 20160314 06:49:03 in /builds/slave/test 06:49:03 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 06:49:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:49:03 INFO - {'append_to_log': False, 06:49:03 INFO - 'base_work_dir': '/builds/slave/test', 06:49:03 INFO - 'blob_upload_branch': 'Fx-Team', 06:49:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:49:03 INFO - 'branch': 'Fx-Team', 06:49:03 INFO - 'buildbot_json_path': 'buildprops.json', 06:49:03 INFO - 'config_files': ('talos/mac_config.py',), 06:49:03 INFO - 'default_actions': ('clobber', 06:49:03 INFO - 'read-buildbot-config', 06:49:03 INFO - 'download-and-extract', 06:49:03 INFO - 'populate-webroot', 06:49:03 INFO - 'create-virtualenv', 06:49:03 INFO - 'install', 06:49:03 INFO - 'run-tests'), 06:49:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:49:03 INFO - 'download_minidump_stackwalk': True, 06:49:03 INFO - 'download_symbols': 'ondemand', 06:49:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:49:03 INFO - 'tooltool.py': '/tools/tooltool.py', 06:49:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:49:03 INFO - '/tools/misc-python/virtualenv.py')}, 06:49:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:49:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:49:03 INFO - 'installer_path': 'installer.exe', 06:49:03 INFO - 'log_level': 'info', 06:49:03 INFO - 'log_name': 'talos', 06:49:03 INFO - 'log_to_console': True, 06:49:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:49:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:49:03 INFO - 'opt_config_files': (), 06:49:03 INFO - 'pip_index': False, 06:49:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:49:03 INFO - 'cmd': ('bash', 06:49:03 INFO - '-c', 06:49:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:49:03 INFO - 'enabled': True, 06:49:03 INFO - 'halt_on_failure': False, 06:49:03 INFO - 'name': 'check_screen_resolution'},), 06:49:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:49:03 INFO - 'cmd': ('bash', 06:49:03 INFO - '-c', 06:49:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:49:03 INFO - 'enabled': True, 06:49:03 INFO - 'halt_on_failure': False, 06:49:03 INFO - 'name': 'check_screen_resolution'},), 06:49:03 INFO - 'run_cmd_checks_enabled': True, 06:49:03 INFO - 'sps_profile': False, 06:49:03 INFO - 'sps_profile_interval': 0, 06:49:03 INFO - 'suite': 'dromaeojs', 06:49:03 INFO - 'system_bits': '32', 06:49:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:49:03 INFO - 'title': 't-yosemite-r7-0190', 06:49:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:49:03 INFO - 'use_talos_json': True, 06:49:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:49:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:49:03 INFO - 'work_dir': 'build'} 06:49:03 INFO - ##### 06:49:03 INFO - ##### Running clobber step. 06:49:03 INFO - ##### 06:49:03 INFO - Running pre-action listener: _resource_record_pre_action 06:49:03 INFO - Running main action method: clobber 06:49:03 INFO - rmtree: /builds/slave/test/build 06:49:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:49:04 INFO - Running post-action listener: _resource_record_post_action 06:49:04 INFO - ##### 06:49:04 INFO - ##### Running read-buildbot-config step. 06:49:04 INFO - ##### 06:49:04 INFO - Running pre-action listener: _resource_record_pre_action 06:49:04 INFO - Running main action method: read_buildbot_config 06:49:04 INFO - Using buildbot properties: 06:49:04 INFO - { 06:49:04 INFO - "project": "", 06:49:04 INFO - "product": "firefox", 06:49:04 INFO - "script_repo_revision": "production", 06:49:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:49:04 INFO - "repository": "", 06:49:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:49:04 INFO - "buildid": "20160314051529", 06:49:04 INFO - "pgo_build": "False", 06:49:04 INFO - "basedir": "/builds/slave/test", 06:49:04 INFO - "buildnumber": 575, 06:49:04 INFO - "slavename": "t-yosemite-r7-0190", 06:49:04 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:49:04 INFO - "platform": "yosemite_r7", 06:49:04 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:49:04 INFO - "branch": "fx-team", 06:49:04 INFO - "repo_path": "integration/fx-team", 06:49:04 INFO - "revision": "2bef59a4476a99e0796bde9502c1bf0744f97182", 06:49:04 INFO - "stage_platform": "macosx64", 06:49:04 INFO - "builduid": "b000b69c79c6480397a4509f0a0e30e5", 06:49:04 INFO - "slavebuilddir": "test" 06:49:04 INFO - } 06:49:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 06:49:04 INFO - Running post-action listener: _resource_record_post_action 06:49:04 INFO - ##### 06:49:04 INFO - ##### Running download-and-extract step. 06:49:04 INFO - ##### 06:49:04 INFO - Running pre-action listener: _resource_record_pre_action 06:49:04 INFO - Running main action method: download_and_extract 06:49:04 INFO - mkdir: /builds/slave/test/build/tests 06:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:04 INFO - https://queue.taskcluster.net/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:49:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:49:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:49:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/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 06:49:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/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 06:49:05 INFO - Downloaded 1199 bytes. 06:49:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 06:49:05 INFO - Using the following test package requirements: 06:49:05 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:49:05 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:49:05 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 06:49:05 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:49:05 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 06:49:05 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:49:05 INFO - u'jsshell-mac.zip'], 06:49:05 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:49:05 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 06:49:05 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:49:05 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:49:05 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 06:49:05 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:49:05 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 06:49:05 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:49:05 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 06:49:05 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:49:05 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 06:49:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:05 INFO - https://queue.taskcluster.net/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:49:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:49:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:49:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/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 06:49:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/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 06:49:08 INFO - Downloaded 17850655 bytes. 06:49:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:49:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:49:11 INFO - Return code: 0 06:49:11 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:11 INFO - https://queue.taskcluster.net/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:49:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:49:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:49:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/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 06:49:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/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 06:49:12 INFO - Downloaded 17850655 bytes. 06:49:12 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'] 06:49:12 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 06:49:16 INFO - Return code: 0 06:49:16 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')]} 06:49:16 INFO - https://queue.taskcluster.net/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:49:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:49:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:49:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/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 06:49:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/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 06:49:17 INFO - Downloaded 10845263 bytes. 06:49:17 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'] 06:49:17 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 06:49:17 INFO - Return code: 0 06:49: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')]} 06:49:17 INFO - https://queue.taskcluster.net/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:49:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:49:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:49:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 06:49:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7NKY8mNT6SuzmbLhqOsdw/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 06:49:21 INFO - Downloaded 111185843 bytes. 06:49:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:49:21 INFO - mkdir: /builds/slave/test/properties 06:49:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:49:21 INFO - Writing to file /builds/slave/test/properties/build_url 06:49:21 INFO - Contents: 06:49:21 INFO - build_url:https://queue.taskcluster.net/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:49:22 INFO - Running post-action listener: _resource_record_post_action 06:49:22 INFO - Running post-action listener: set_extra_try_arguments 06:49:22 INFO - ##### 06:49:22 INFO - ##### Running populate-webroot step. 06:49:22 INFO - ##### 06:49:22 INFO - Running pre-action listener: _resource_record_pre_action 06:49:22 INFO - Running main action method: populate_webroot 06:49:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:49:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:49:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:49:22 INFO - '--tppagecycles', 06:49:22 INFO - '7'], 06:49:22 INFO - 'tests': ['tsvgm']}}, 06:49:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:49:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:49:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:49:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:49:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:49:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:49:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:22 INFO - 'talos_options': ['--e10s'], 06:49:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:22 INFO - 'tests': ['damp', 'tps']}, 06:49:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:22 INFO - 'talos_options': ['--e10s'], 06:49:22 INFO - 'tests': ['damp', 'tps']}, 06:49:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:49:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:49:22 INFO - 'other': {'tests': ['a11yr', 06:49:22 INFO - 'ts_paint', 06:49:22 INFO - 'tpaint', 06:49:22 INFO - 'sessionrestore', 06:49:22 INFO - 'sessionrestore_no_auto_restore', 06:49:22 INFO - 'tabpaint']}, 06:49:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:49:22 INFO - 'tests': ['a11yr', 06:49:22 INFO - 'ts_paint', 06:49:22 INFO - 'tpaint', 06:49:22 INFO - 'sessionrestore', 06:49:22 INFO - 'sessionrestore_no_auto_restore', 06:49:22 INFO - 'tabpaint']}, 06:49:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:49:22 INFO - 'tests': ['a11yr', 06:49:22 INFO - 'ts_paint', 06:49:22 INFO - 'tpaint', 06:49:22 INFO - 'sessionrestore', 06:49:22 INFO - 'sessionrestore_no_auto_restore', 06:49:22 INFO - 'tabpaint']}, 06:49:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:49:22 INFO - 'tests': ['a11yr', 06:49:22 INFO - 'ts_paint', 06:49:22 INFO - 'tpaint', 06:49:22 INFO - 'sessionrestore', 06:49:22 INFO - 'sessionrestore_no_auto_restore', 06:49:22 INFO - 'tabpaint']}, 06:49:22 INFO - 'other_l64': {'tests': ['a11yr', 06:49:22 INFO - 'ts_paint', 06:49:22 INFO - 'tpaint', 06:49:22 INFO - 'sessionrestore', 06:49:22 INFO - 'sessionrestore_no_auto_restore', 06:49:22 INFO - 'tabpaint']}, 06:49:22 INFO - 'other_nol64': {'tests': ['a11yr', 06:49:22 INFO - 'ts_paint', 06:49:22 INFO - 'tpaint', 06:49:22 INFO - 'sessionrestore', 06:49:22 INFO - 'sessionrestore_no_auto_restore', 06:49:22 INFO - 'tabpaint']}, 06:49:22 INFO - 'svgr': {'tests': ['tsvgx', 06:49:22 INFO - 'tsvgr_opacity', 06:49:22 INFO - 'tart', 06:49:22 INFO - 'tscrollx', 06:49:22 INFO - 'cart']}, 06:49:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:49:22 INFO - 'tests': ['tsvgx', 06:49:22 INFO - 'tsvgr_opacity', 06:49:22 INFO - 'tart', 06:49:22 INFO - 'tscrollx', 06:49:22 INFO - 'cart']}, 06:49:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:22 INFO - 'tests': ['tp5o']}, 06:49:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:22 INFO - 'talos_options': ['--e10s'], 06:49:22 INFO - 'tests': ['tp5o']}, 06:49:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:22 INFO - 'talos_options': ['--xperf_path', 06:49:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:22 INFO - 'tests': ['tp5n']}, 06:49:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:22 INFO - 'talos_options': ['--e10s', 06:49:22 INFO - '--xperf_path', 06:49:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:22 INFO - 'tests': ['tp5n']}}, 06:49:22 INFO - 'talos.zip': {'path': '', 06:49:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:49:22 INFO - Running post-action listener: _resource_record_post_action 06:49:22 INFO - ##### 06:49:22 INFO - ##### Running create-virtualenv step. 06:49:22 INFO - ##### 06:49:22 INFO - Running pre-action listener: _resource_record_pre_action 06:49:22 INFO - Running main action method: create_virtualenv 06:49:22 INFO - Creating virtualenv /builds/slave/test/build/venv 06:49:22 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 06:49:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:49:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:49:22 INFO - Using real prefix '/tools/python27' 06:49:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:49:22 INFO - Installing distribute.............................................................................................................................................................................................done. 06:49:25 INFO - Installing pip.................done. 06:49:25 INFO - Return code: 0 06:49:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10216ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021744c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b0ca4bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010d30>, '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 0x101e34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102007b20>, '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.qRbet5Vm6v/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.YWknkLGiJB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 06:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:49:25 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 06:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRbet5Vm6v/Render', 06:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:25 INFO - 'HOME': '/Users/cltbld', 06:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:25 INFO - 'LOGNAME': 'cltbld', 06:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:25 INFO - 'MOZ_NO_REMOTE': '1', 06:49:25 INFO - 'NO_EM_RESTART': '1', 06:49:25 INFO - 'PAGER': '/bin/cat', 06:49:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:25 INFO - 'PWD': '/builds/slave/test', 06:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:25 INFO - 'SHELL': '/bin/bash', 06:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWknkLGiJB/Listeners', 06:49:25 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 06:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:25 INFO - 'USER': 'cltbld', 06:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:25 INFO - 'XPC_FLAGS': '0x0', 06:49:25 INFO - 'XPC_SERVICE_NAME': '0', 06:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:26 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 06:49:26 INFO - Cleaning up... 06:49:26 INFO - Return code: 0 06:49:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10216ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021744c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b0ca4bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010d30>, '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 0x101e34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102007b20>, '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.qRbet5Vm6v/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.YWknkLGiJB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 06:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:49:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRbet5Vm6v/Render', 06:49:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:26 INFO - 'HOME': '/Users/cltbld', 06:49:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:26 INFO - 'LOGNAME': 'cltbld', 06:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:26 INFO - 'MOZ_NO_REMOTE': '1', 06:49:26 INFO - 'NO_EM_RESTART': '1', 06:49:26 INFO - 'PAGER': '/bin/cat', 06:49:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:26 INFO - 'PWD': '/builds/slave/test', 06:49:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:26 INFO - 'SHELL': '/bin/bash', 06:49:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWknkLGiJB/Listeners', 06:49:26 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 06:49:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:26 INFO - 'USER': 'cltbld', 06:49:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:26 INFO - 'XPC_FLAGS': '0x0', 06:49:26 INFO - 'XPC_SERVICE_NAME': '0', 06:49:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:26 INFO - Downloading/unpacking psutil>=0.7.1 06:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:49:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:29 INFO - Installing collected packages: psutil 06:49:29 INFO - Running setup.py install for psutil 06:49:29 INFO - building 'psutil._psutil_osx' extension 06:49:29 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 06:49:30 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 06:49:30 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 06:49:30 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 06:49:30 INFO - building 'psutil._psutil_posix' extension 06:49:30 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 06:49:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:49:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:49:30 INFO - ^ 06:49:30 INFO - 1 warning generated. 06:49:30 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 06:49:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:30 INFO - Successfully installed psutil 06:49:30 INFO - Cleaning up... 06:49:30 INFO - Return code: 0 06:49:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:30 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 0x10216ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021744c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b0ca4bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010d30>, '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 0x101e34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102007b20>, '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.qRbet5Vm6v/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.YWknkLGiJB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 06:49:30 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 06:49:30 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 06:49:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRbet5Vm6v/Render', 06:49:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:30 INFO - 'HOME': '/Users/cltbld', 06:49:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:30 INFO - 'LOGNAME': 'cltbld', 06:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:30 INFO - 'MOZ_NO_REMOTE': '1', 06:49:30 INFO - 'NO_EM_RESTART': '1', 06:49:30 INFO - 'PAGER': '/bin/cat', 06:49:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:30 INFO - 'PWD': '/builds/slave/test', 06:49:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:30 INFO - 'SHELL': '/bin/bash', 06:49:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWknkLGiJB/Listeners', 06:49:30 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 06:49:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:30 INFO - 'USER': 'cltbld', 06:49:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:30 INFO - 'XPC_FLAGS': '0x0', 06:49:30 INFO - 'XPC_SERVICE_NAME': '0', 06:49:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:49:33 INFO - Installing collected packages: mozsystemmonitor 06:49:33 INFO - Running setup.py install for mozsystemmonitor 06:49:33 INFO - Successfully installed mozsystemmonitor 06:49:33 INFO - Cleaning up... 06:49:33 INFO - Return code: 0 06:49:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:49:33 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')]} 06:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:33 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')]} 06:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:33 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 0x10216ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021744c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b0ca4bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010d30>, '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 0x101e34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102007b20>, '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.qRbet5Vm6v/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.YWknkLGiJB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 06:49:33 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 06:49:33 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 06:49:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRbet5Vm6v/Render', 06:49:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:33 INFO - 'HOME': '/Users/cltbld', 06:49:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:33 INFO - 'LOGNAME': 'cltbld', 06:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:33 INFO - 'MOZ_NO_REMOTE': '1', 06:49:33 INFO - 'NO_EM_RESTART': '1', 06:49:33 INFO - 'PAGER': '/bin/cat', 06:49:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:33 INFO - 'PWD': '/builds/slave/test', 06:49:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:33 INFO - 'SHELL': '/bin/bash', 06:49:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWknkLGiJB/Listeners', 06:49:33 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 06:49:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:33 INFO - 'USER': 'cltbld', 06:49:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:33 INFO - 'XPC_FLAGS': '0x0', 06:49:33 INFO - 'XPC_SERVICE_NAME': '0', 06:49:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:34 INFO - Downloading/unpacking blobuploader==1.2.4 06:49:34 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 06:49:34 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 06:49:34 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 06:49:34 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 06:49:34 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 06:49:34 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 06:49:36 INFO - Downloading blobuploader-1.2.4.tar.gz 06:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:49:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:49: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 06:49: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 06:49: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 06:49: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 06:49: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 06:49: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 06:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:49:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:37 INFO - Downloading docopt-0.6.1.tar.gz 06:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:49:37 INFO - Installing collected packages: blobuploader, requests, docopt 06:49:37 INFO - Running setup.py install for blobuploader 06:49:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:49:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:49:37 INFO - Running setup.py install for requests 06:49:38 INFO - Running setup.py install for docopt 06:49:38 INFO - Successfully installed blobuploader requests docopt 06:49:38 INFO - Cleaning up... 06:49:38 INFO - Return code: 0 06:49:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:38 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 0x10216ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021744c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b0ca4bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010d30>, '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 0x101e34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102007b20>, '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.qRbet5Vm6v/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.YWknkLGiJB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 06:49:38 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 06:49:38 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 06:49:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRbet5Vm6v/Render', 06:49:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:38 INFO - 'HOME': '/Users/cltbld', 06:49:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:38 INFO - 'LOGNAME': 'cltbld', 06:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:38 INFO - 'MOZ_NO_REMOTE': '1', 06:49:38 INFO - 'NO_EM_RESTART': '1', 06:49:38 INFO - 'PAGER': '/bin/cat', 06:49:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:38 INFO - 'PWD': '/builds/slave/test', 06:49:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:38 INFO - 'SHELL': '/bin/bash', 06:49:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWknkLGiJB/Listeners', 06:49:38 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 06:49:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:38 INFO - 'USER': 'cltbld', 06:49:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:38 INFO - 'XPC_FLAGS': '0x0', 06:49:38 INFO - 'XPC_SERVICE_NAME': '0', 06:49:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:49:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Eak_eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:49:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-2CmV8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:49:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-3WzuHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:49:39 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-IuSdyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:49:39 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-5EzFlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:49:39 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-0ovJqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:49:39 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-PAUHN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:49:39 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-wSfYkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:49:39 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-38l_6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:49:39 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-0r2RWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:49:39 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-vIFApR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:49:39 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-MpvPvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:49:40 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Tiyf8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:49:40 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-XhRyrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:40 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-e6dTCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:49:40 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-l4agl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:49:40 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-HIbHzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:49:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:49:40 INFO - Running setup.py install for manifestparser 06:49:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:49:40 INFO - Running setup.py install for mozcrash 06:49:40 INFO - Running setup.py install for mozdebug 06:49:40 INFO - Running setup.py install for mozdevice 06:49:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:49:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:49:41 INFO - Running setup.py install for mozfile 06:49:41 INFO - Running setup.py install for mozhttpd 06:49:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:49:41 INFO - Running setup.py install for mozinfo 06:49:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:49:41 INFO - Running setup.py install for mozInstall 06:49:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:49:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:49:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:49:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:49:41 INFO - Running setup.py install for mozleak 06:49:41 INFO - Running setup.py install for mozlog 06:49:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:49:41 INFO - Running setup.py install for moznetwork 06:49:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:49:42 INFO - Running setup.py install for mozprocess 06:49:42 INFO - Running setup.py install for mozprofile 06:49:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:49:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:49:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:49:42 INFO - Running setup.py install for mozrunner 06:49:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:49:42 INFO - Running setup.py install for mozscreenshot 06:49:42 INFO - Running setup.py install for moztest 06:49:42 INFO - Running setup.py install for mozversion 06:49:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:49:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:49:43 INFO - Cleaning up... 06:49:43 INFO - Return code: 0 06:49:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:43 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 0x10216ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021744c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b0ca4bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010d30>, '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 0x101e34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102007b20>, '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.qRbet5Vm6v/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.YWknkLGiJB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 06:49:43 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 06:49:43 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 06:49:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRbet5Vm6v/Render', 06:49:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:43 INFO - 'HOME': '/Users/cltbld', 06:49:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:43 INFO - 'LOGNAME': 'cltbld', 06:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:43 INFO - 'MOZ_NO_REMOTE': '1', 06:49:43 INFO - 'NO_EM_RESTART': '1', 06:49:43 INFO - 'PAGER': '/bin/cat', 06:49:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:43 INFO - 'PWD': '/builds/slave/test', 06:49:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:43 INFO - 'SHELL': '/bin/bash', 06:49:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWknkLGiJB/Listeners', 06:49:43 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 06:49:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:43 INFO - 'USER': 'cltbld', 06:49:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:43 INFO - 'XPC_FLAGS': '0x0', 06:49:43 INFO - 'XPC_SERVICE_NAME': '0', 06:49:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:49:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-wxyTFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:49:43 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)) 06:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:49:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-E03J4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:49:43 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)) 06:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:49:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-ayoHvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:49:43 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)) 06:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:49:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-UoeqSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:49:43 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)) 06:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:49:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-g5A2ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:49:43 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)) 06:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:49:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-FjX2HZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:49:44 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)) 06:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:49:44 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-PxFTQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:49:44 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)) 06:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:49:44 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-lowOp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:49:44 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)) 06:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:49:44 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-XUSxiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:49:44 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)) 06:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:49:44 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-ciRq0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:49:44 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)) 06:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:49:44 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-QV4woX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:49:44 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)) 06:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:49:44 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-UCsKFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:49:44 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)) 06:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:49:44 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-NIQVX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:49:44 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)) 06:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:49:44 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-XTJnab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:49:44 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)) 06:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:44 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-vDF9nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:44 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)) 06:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:49:44 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-YBQulo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:49:45 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)) 06:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:49:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-IxLhfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:49:45 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)) 06:49:45 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)) 06:49:45 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)) 06:49:45 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)) 06:49:45 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)) 06:49:45 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)) 06:49:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:49:45 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 06:49:45 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 06:49:45 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 06:49:45 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 06:49:45 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 06:49:45 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 06:49:47 INFO - Downloading blessings-1.6.tar.gz 06:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:49:47 INFO - Installing collected packages: blessings 06:49:47 INFO - Running setup.py install for blessings 06:49:47 INFO - Successfully installed blessings 06:49:47 INFO - Cleaning up... 06:49:47 INFO - Return code: 0 06:49:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:49:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:49:48 INFO - Reading from file tmpfile_stdout 06:49:48 INFO - Current package versions: 06:49:48 INFO - blessings == 1.6 06:49:48 INFO - blobuploader == 1.2.4 06:49:48 INFO - docopt == 0.6.1 06:49:48 INFO - manifestparser == 1.1 06:49:48 INFO - mozInstall == 1.12 06:49:48 INFO - mozcrash == 0.17 06:49:48 INFO - mozdebug == 0.1 06:49:48 INFO - mozdevice == 0.48 06:49:48 INFO - mozfile == 1.2 06:49:48 INFO - mozhttpd == 0.7 06:49:48 INFO - mozinfo == 0.9 06:49:48 INFO - mozleak == 0.1 06:49:48 INFO - mozlog == 3.1 06:49:48 INFO - moznetwork == 0.27 06:49:48 INFO - mozprocess == 0.22 06:49:48 INFO - mozprofile == 0.28 06:49:48 INFO - mozrunner == 6.11 06:49:48 INFO - mozscreenshot == 0.1 06:49:48 INFO - mozsystemmonitor == 0.0 06:49:48 INFO - moztest == 0.7 06:49:48 INFO - mozversion == 1.4 06:49:48 INFO - psutil == 3.1.1 06:49:48 INFO - requests == 1.2.3 06:49:48 INFO - wsgiref == 0.1.2 06:49:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:48 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 0x10216ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021744c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b0ca4bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010d30>, '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 0x101e34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102007b20>, '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.qRbet5Vm6v/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.YWknkLGiJB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 06:49:48 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 06:49:48 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 06:49:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRbet5Vm6v/Render', 06:49:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:48 INFO - 'HOME': '/Users/cltbld', 06:49:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:48 INFO - 'LOGNAME': 'cltbld', 06:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:48 INFO - 'MOZ_NO_REMOTE': '1', 06:49:48 INFO - 'NO_EM_RESTART': '1', 06:49:48 INFO - 'PAGER': '/bin/cat', 06:49:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:48 INFO - 'PWD': '/builds/slave/test', 06:49:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:48 INFO - 'SHELL': '/bin/bash', 06:49:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWknkLGiJB/Listeners', 06:49:48 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 06:49:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:48 INFO - 'USER': 'cltbld', 06:49:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:48 INFO - 'XPC_FLAGS': '0x0', 06:49:48 INFO - 'XPC_SERVICE_NAME': '0', 06:49:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:48 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)) 06:49:48 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)) 06:49:48 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)) 06:49:48 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)) 06:49:48 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)) 06:49:48 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)) 06:49:48 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)) 06:49:48 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)) 06:49:48 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)) 06:49:48 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)) 06:49:48 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)) 06:49:48 INFO - Cleaning up... 06:49:48 INFO - Return code: 0 06:49:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:48 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 0x10216ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021744c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b0ca4bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010d30>, '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 0x101e34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102007b20>, '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.qRbet5Vm6v/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.YWknkLGiJB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 06:49:48 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 06:49:48 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 06:49:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRbet5Vm6v/Render', 06:49:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:48 INFO - 'HOME': '/Users/cltbld', 06:49:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:48 INFO - 'LOGNAME': 'cltbld', 06:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:48 INFO - 'MOZ_NO_REMOTE': '1', 06:49:48 INFO - 'NO_EM_RESTART': '1', 06:49:48 INFO - 'PAGER': '/bin/cat', 06:49:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:48 INFO - 'PWD': '/builds/slave/test', 06:49:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:48 INFO - 'SHELL': '/bin/bash', 06:49:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWknkLGiJB/Listeners', 06:49:48 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 06:49:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:48 INFO - 'USER': 'cltbld', 06:49:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:48 INFO - 'XPC_FLAGS': '0x0', 06:49:48 INFO - 'XPC_SERVICE_NAME': '0', 06:49:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:48 INFO - Downloading/unpacking jsonschema 06:49:48 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 06:49:48 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 06:49:48 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 06:49:48 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 06:49:48 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 06:49:48 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 06:49:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:49:50 INFO - Downloading/unpacking functools32 (from jsonschema) 06:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:51 INFO - Downloading functools32-3.2.3-2.tar.gz 06:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:49:51 INFO - warning: no files found matching '*.txt' 06:49:51 INFO - no previously-included directories found matching 'build' 06:49:51 INFO - no previously-included directories found matching 'dist' 06:49:51 INFO - no previously-included directories found matching '.git*' 06:49:51 INFO - Installing collected packages: jsonschema, functools32 06:49:51 INFO - Running setup.py install for functools32 06:49:51 INFO - warning: no files found matching '*.txt' 06:49:51 INFO - no previously-included directories found matching 'build' 06:49:51 INFO - no previously-included directories found matching 'dist' 06:49:51 INFO - no previously-included directories found matching '.git*' 06:49:51 INFO - Successfully installed jsonschema functools32 06:49:51 INFO - Cleaning up... 06:49:51 INFO - Return code: 0 06:49:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:49: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')]} 06:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49: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')]} 06:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:51 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 0x10216ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021744c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b0ca4bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102010d30>, '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 0x101e34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102007b20>, '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.qRbet5Vm6v/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.YWknkLGiJB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 06:49:51 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 06:49:51 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 06:49:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRbet5Vm6v/Render', 06:49:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:51 INFO - 'HOME': '/Users/cltbld', 06:49:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:51 INFO - 'LOGNAME': 'cltbld', 06:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:51 INFO - 'MOZ_NO_REMOTE': '1', 06:49:51 INFO - 'NO_EM_RESTART': '1', 06:49:51 INFO - 'PAGER': '/bin/cat', 06:49:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:51 INFO - 'PWD': '/builds/slave/test', 06:49:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:51 INFO - 'SHELL': '/bin/bash', 06:49:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWknkLGiJB/Listeners', 06:49:51 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 06:49:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:51 INFO - 'USER': 'cltbld', 06:49:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:51 INFO - 'XPC_FLAGS': '0x0', 06:49:51 INFO - 'XPC_SERVICE_NAME': '0', 06:49:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:52 INFO - Downloading/unpacking flake8 06:49:52 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 06:49:52 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 06:49:52 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 06:49:52 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 06:49:52 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 06:49:52 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 06:49:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:49:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:49:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:49:55 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 06:49:55 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 06:49:55 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 06:49:55 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 06:49:55 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 06:49:55 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 06:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:49:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:49:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:49:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:49:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:49:55 INFO - no previously-included directories found matching 'docs/_build' 06:49:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:49:55 INFO - Running setup.py install for pep8 06:49:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:49:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:49:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:49:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:49:55 INFO - no previously-included directories found matching 'docs/_build' 06:49:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:49:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:49:55 INFO - Cleaning up... 06:49:56 INFO - Return code: 0 06:49:56 INFO - Running post-action listener: _resource_record_post_action 06:49:56 INFO - Running post-action listener: _start_resource_monitoring 06:49:56 INFO - Starting resource monitoring. 06:49:56 INFO - ##### 06:49:56 INFO - ##### Running install step. 06:49:56 INFO - ##### 06:49:56 INFO - Running pre-action listener: _resource_record_pre_action 06:49:56 INFO - Running main action method: install 06:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:49:56 INFO - Reading from file tmpfile_stdout 06:49:56 INFO - Detecting whether we're running mozinstall >=1.0... 06:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:49:56 INFO - Reading from file tmpfile_stdout 06:49:56 INFO - Output received: 06:49:56 INFO - Usage: mozinstall [options] installer 06:49:56 INFO - Options: 06:49:56 INFO - -h, --help show this help message and exit 06:49:56 INFO - -d DEST, --destination=DEST 06:49:56 INFO - Directory to install application into. [default: 06:49:56 INFO - "/builds/slave/test"] 06:49:56 INFO - --app=APP Application being installed. [default: firefox] 06:49:56 INFO - mkdir: /builds/slave/test/build/application 06:49:56 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'] 06:49:56 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 06:50:30 INFO - Reading from file tmpfile_stdout 06:50:30 INFO - Output received: 06:50:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:50:30 INFO - Running post-action listener: _resource_record_post_action 06:50:30 INFO - ##### 06:50:30 INFO - ##### Running run-tests step. 06:50:30 INFO - ##### 06:50:30 INFO - Running pre-action listener: _resource_record_pre_action 06:50:30 INFO - Running main action method: run_tests 06:50:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:50:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:50:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:50:30 INFO - 2016-03-14 06:50:30.399 screenresolution[1651:8500] starting screenresolution argv=screenresolution get 06:50:30 INFO - 2016-03-14 06:50:30.402 screenresolution[1651:8500] Display 0: 1600x1200x32@60 06:50:30 INFO - 2016-03-14 06:50:30.407 screenresolution[1652:8502] starting screenresolution argv=screenresolution list 06:50:30 INFO - Available Modes on Display 0 06:50:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:50:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:50:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:50:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:50:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:50:30 INFO - Intel Iris: 06:50:30 INFO - Chipset Model: Intel Iris 06:50:30 INFO - Type: GPU 06:50:30 INFO - Bus: Built-In 06:50:30 INFO - VRAM (Dynamic, Max): 1536 MB 06:50:30 INFO - Vendor: Intel (0x8086) 06:50:30 INFO - Device ID: 0x0a2e 06:50:30 INFO - Revision ID: 0x0009 06:50:30 INFO - Displays: 06:50:30 INFO - Display: 06:50:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:50:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:50:30 INFO - Display Serial Number: 1600x1200 60 06:50:30 INFO - Main Display: Yes 06:50:30 INFO - Mirror: Off 06:50:30 INFO - Online: Yes 06:50:30 INFO - Rotation: Supported 06:50:30 INFO - Return code: 0 06:50:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:50:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:50:30 INFO - Python 2.7.3 06:50:30 INFO - Return code: 0 06:50:30 INFO - grabbing minidump binary from tooltool 06:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:30 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 0x102010d30>, '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 0x101e34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102007b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:50:30 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 06:50:30 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 06:50:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:50:30 INFO - Return code: 0 06:50:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:50:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:50:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:50:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:50:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:50:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:50:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:50:31 INFO - Return code: 0 06:50:31 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/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--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 06:50:31 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/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0190 --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 06:50:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRbet5Vm6v/Render', 06:50:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:31 INFO - 'HOME': '/Users/cltbld', 06:50:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:31 INFO - 'LOGNAME': 'cltbld', 06:50:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:50:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:31 INFO - 'MOZ_NO_REMOTE': '1', 06:50:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:50:31 INFO - 'NO_EM_RESTART': '1', 06:50:31 INFO - 'PAGER': '/bin/cat', 06:50:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:31 INFO - 'PWD': '/builds/slave/test', 06:50:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:50:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:31 INFO - 'SHELL': '/bin/bash', 06:50:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YWknkLGiJB/Listeners', 06:50:31 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 06:50:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:31 INFO - 'USER': 'cltbld', 06:50:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:31 INFO - 'XPC_FLAGS': '0x0', 06:50:31 INFO - 'XPC_SERVICE_NAME': '0', 06:50:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:31 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/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--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 06:50:32 INFO - mozversion application_buildid: 20160314051529 06:50:32 INFO - mozversion application_changeset: 2bef59a4476a99e0796bde9502c1bf0744f97182 06:50:32 INFO - mozversion application_display_name: Nightly 06:50:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:50:32 INFO - mozversion application_name: Firefox 06:50:32 INFO - mozversion application_remotingname: firefox 06:50:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:50:32 INFO - mozversion application_vendor: Mozilla 06:50:32 INFO - mozversion application_version: 48.0a1 06:50:32 INFO - mozversion platform_buildid: 20160314051529 06:50:32 INFO - mozversion platform_changeset: 2bef59a4476a99e0796bde9502c1bf0744f97182 06:50:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:50:32 INFO - mozversion platform_version: 48.0a1 06:50:32 INFO - using testdate: 1457963432 06:50:32 INFO - actual date: 1457963432 06:50:32 INFO - starting webserver on 'localhost:49273' 06:50:32 INFO - SUITE-START | Running 2 tests 06:50:32 INFO - TEST-START | dromaeo_css 06:50:32 INFO - operating with platform_type : mac_ 06:50:32 INFO - Initialising browser for dromaeo_css test... 06:50:32 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmppCvmGO/profile http://localhost:49273/getInfo.html) 06:50:34 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 06:50:34 INFO - PROCESS | 1670 | colorDepth:24 06:50:34 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 06:50:34 INFO - PROCESS | 1670 | __metrics 06:50:34 INFO - PROCESS | 1670 | 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" 06:50:34 ERROR - PROCESS | 1670 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:50:35 INFO - TEST-INFO | 1670: exit 0 06:50:35 INFO - Browser initialized. 06:50:35 INFO - Running cycle 1/1 for dromaeo_css test... 06:50:35 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmppCvmGO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:50:47 INFO - PROCESS | 1674 | RSS: Main: 243396608 06:50:47 INFO - PROCESS | 1674 | 06:51:37 INFO - PROCESS | 1674 | 1457963497857 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] 06:53:48 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 06:53:49 INFO - PROCESS | 1674 | RSS: Main: 382693376 06:53:49 INFO - PROCESS | 1674 | 06:56:51 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 06:56:52 INFO - PROCESS | 1674 | RSS: Main: 380903424 06:56:52 INFO - PROCESS | 1674 | 06:59:54 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 06:59:55 INFO - PROCESS | 1674 | RSS: Main: 378359808 06:59:55 INFO - PROCESS | 1674 | 07:02:57 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 07:02:57 INFO - PROCESS | 1674 | RSS: Main: 337739776 07:02:57 INFO - PROCESS | 1674 | 07:06:00 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 07:06:01 INFO - PROCESS | 1674 | RSS: Main: 334450688 07:06:01 INFO - PROCESS | 1674 | 07:09:04 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 07:09:04 INFO - PROCESS | 1674 | RSS: Main: 407232512 07:09:04 INFO - PROCESS | 1674 | 07:09:04 INFO - PROCESS | 1674 | __start_tp_report 07:09:04 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 07:09:04 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 07:09:04 INFO - PROCESS | 1674 | |i|pagename|runs| 07:09:04 INFO - PROCESS | 1674 | |0;dojo.html;2857.328527795968;3439.2433664593796;3445.1559367954856;3450.689437950584;3504.5093686883843;5499.670019798805;5602.131669591215;5616.297962754656;5623.156526521018;5634.690092044936;5585.218069470277;5592.189132575774;5609.80365687201;5684.261046064016;5705.001624715668;5040.798368065273;5079.339685840845;5092.057969275677;5103.923441148386;5186.92219616706;5159.5614372778355;5191.169412893919;5209.505097015796;5209.791608335662;5269.8946021079555;5048.621353398491;5083.415407228179;5170.3278573785165;5177.016366890279;5208.947910520922;5111.284420181178;5146.228065790124;5153.433122356538;5162.967406518674;5169.663971841818;5095.515925987025;5126.641135120543;5139.717315547643;5154.123798954187;5179.585633149339;5380;5474.343078830566;5506.752196151183;5556.444355564452;5564.1931919871395;6119.694015299217;6208.192934918477;6214.192155019864;6218.378162183745;6229.345918678564;6177;6246.593971391891;6255.218097737783;6261.405166509175;6265.906011409833;4755.857324280277;5571.387147413781;5632.802851900205;5702.2301989231755;5746.02317606008;6236;6249.9062514062325;6255.280642726054;6273.0904018917;6278.215223097113;5669.943300567024;5998.070299103646;6021.3677563856045;6033.7586496540525;6065.332813390523;6049.122877182872;6138.970878344271;6145.324014358417;6218.160548325918;6238.532110091761;6137.4689182037;6149.877002459926;6152;6160;6167.259928808482;6183.536234782409;6194.008958566607;6194.853952018891;6197.380261973766;6214.5028397728975;4765.309030190603;4802.135615589227;4851.272309153655;4859.514048595183;4911.484294149134;4351.521332653406;4390.8024138913825;4394.582514661102;4396.648268138541;4399.62603178727;5568.081266590967;5641.802536911188;5645.830625081254;5646.802361917313;5654.4062873398525;6137.8979746733885;6140.13616995768;6144.907826382608;6234.5635805494085;6283.59156654816;5621.0444224481935;5631.802886898939;5637.041702910515;5645.830625081254;5677.347105082886;5262.052830490472;5264.341957255343;5265.868353291198;5266.657667251617;5336.813211537577;6180.938190618036;6197.659128747962;6256.155419018374;6264.467520260738;6276.560640755195;6216.564840461125;6228.252609686867;6240.375962403723;6245.531585131042;6255.812325630239;6145.801568694062;6252.468540174136;6260;6262.3111457738705;6268.4671802897265;6076.878462430638;6101.328853826164;6150.292716337678;6150.477209437069;6159.29168145669;6200.782972595937;6205.069239614094;6221.377862213742;6224.906626400517;6225.252969643671;5908;5976.402359763989;6030.75876964934;6046.183765191643;6065.848353791191;6029.306629737636;6038.426349496791;6069.9089513656445;6076.513878889767;6112.510999119971;5618.213450116905;5819.5635327351465;5854.356020837789;5864.237649105589;5874.647521148745;5783.306003279633;5991.820245392645;6020.819375418744;6039.214902062704;6072.8785424292155;4587.816487340469;5027.396712394536;5912.231409916683;5916.526677865846;5935.465808077293 07:09:04 INFO - PROCESS | 1674 | |1;ext.html;494.8445380037612;512.423523536022;585.7406575861896;611.9326874043855;633.1800318587428;38440;39188.60811391885;39227.60772392275;39293.017674558185;39338.60661393385;41921.79039104808;42424.787876060655;42428.57571424285;42469.150616987645;42480.57519424805;9427.858582121256;9656.130948214659;9662.903370966305;9667.516624168764;9736.123748862601;9494.71515854522;9643.90356096437;9645.22838172948;9658.661946831862;9675.467849268287;9750.36622619531;9835.01649835018;9838.90161098387;9842.60629574816;9860.11258986691;9728.075832795874;9806.215502759762;9807.90192098077;9810.362326448758;9828.852567211497;9628.085331893459;9755.365901216399;9757.268204884662;9762.853557196648;9769.169620582259;40989;41356.79321603403;41447.792761036;41514;41707;3215.3569286142865;3219.7585181111513;3249.203945033482;3274.476083826576;3483.425234836249;29123.708762912313;29539.966101186354;29585.408291834043;29622.555661664876;29665;2732.385213327005;2740.2464322311325;2743.341598016462;2749.9037533686223;2817.7745780337523;479008;481712;482125;482531;483643.74534382013;45349.773251133534;65018;66542;66602.66698666476;66686.99969500462;44734;44810.10379792451;44858.32712509315;44869.10261794746;45024;15566.299516521784;15790.289436975363;15815.36738530469;15824.76262856058;15836.604084897739;12679.746405071846;12760.425780839885;12771.489140434465;12776;12777.616671499869;14699.26503674812;14746.557603271918;14754.778678319833;14836.18400987956;14944.40222391114;6351.110844481776;6510.08858759774;6519.934800652028;6521.5108866834225;6572.86854262912;953.1326492891435;955.2024059910053;963.4556475591269;973.5813600152003;1006.6074231049896;28734.137975860758;29133.708662913523;29166.416671666448;29638;29687.406251874843;927.1701826864918;1052.1267348101057;1102.3000394749392;1165.4813607944384;1215.969600759988;14047.297635118202;14122.71754564903;14324.283785810669;14346.500318877494;14470;519311;533163.3341833344;533617.3319133379;535278;536398;48733;57607.423925761046;59220.40779592149;59750;59898;1178.2871362825367;1316.2628927800463;1333.0668532027619;1429.635442962038;1480.851914808532;28252.011179608617;28411.289717757223;28615.570766438104;28918;28949.84200631951;45648;46134.76932615315;46589.3011604833;46632.30051549162;46639.53360466352;311617;313177;314166;314213;314759;28429.289267768472;32880;33762;33763.493547597296;33826.49260261147;42194.72193230879;44124.77937610292;44235.55764442314;44279.335809962235;44889.73547512981;33529.66470335265;34328.656713432545;36046.73836415713;36580.26839463143;36590.63409365872;35539.82230088833;35694;35710.8214458926;36605;36763;36564.81717591395;36794.29688398303;36815.26369472542;38108.42837357497;38735;29979.702232754815;30818;31381.843090785314;31477.8426107868;31481.740730371446;19729.506762331057;21519;24427.75572244326;24956;24968.375790604652 07:09:04 INFO - PROCESS | 1674 | |2;jquery.html;336.1695567634232;362.4689829399929;363.91629925117223;365.21478820535845;373.5554689918998;15853.68292634148;19601.607967840635;20242.886641234727;20921.372358829223;20927.058282377293;19351.516212094706;19631.214751409963;20314.89842550789;20321.59356812863;20377.898110509464;5714.857128571788;5881.088431293135;5936.673482958436;5936.970315148418;5937.732802023897;4221.387898754679;4389.363542286366;5755.798547050854;6165.907511387333;6383.946648802965;6315.684215789192;6331.113644089831;6336.651484168369;6337.524685648595;6351.110844481776;6123.877522449548;6208.379162083801;6275.843103922392;6297.33877942814;6312.3372045934975;3705.110773414388;5198.792048318101;5425.457454254582;5442.782288708447;5456.317960254968;23698.40753981147;24509;24581.38546536333;24619.384515387257;24690.25929222126;1751.7372394140853;2120.0883620043373;2133.7332833395826;2197.3407977606653;2566.7304932981956;14073;14295.9992800504;14535;14845.331960061716;14981.475648352256;1681.9327226911032;1753.289917583368;1786.553361659585;1791.1581556668345;1833.7432759413693;88367.67448488278;92220;99950.50024749902;104507.4774626122;104730.47634761853;10182.338148020355;10366.740831479123;10613.5223914924;10633.46832658364;10745.892541074645;10771.946140269249;12726.490940362282;12794.040446966515;12799.29603871796;12830.743385132246;8278.379121565908;8303;8376.706815261437;8602.956985215034;8690.522021288889;8930.419522731001;8930.732078037669;8956;9034.186923176945;9052.502112383881;5119.48805119485;6077.787277445268;6185.752569897154;6187.504999600022;6260.217472815898;1665.300573759024;1672.1889883406539;1746.56335916021;1749.9850086949539;1774.698301288784;891.7458524320667;928.6749637626912;1002.8295189817749;1033.2405681823852;1051.01687367015;21105.944702764802;21512.354629361143;21590.460238494165;21713.78286217149;21835.344939651837;928.6007016982762;967.4388854464394;1022.8005538919988;1057.5558265528496;1076.0799516413354;11125.666230013112;11498.195126341076;11532.88467115335;11555.711107222218;11617.419129043514;560694;614963;624563;629907;630641;110207;112070;112533.43733281444;113181.434092829;114725;996.4170959988343;1011.1506334678758;1038.6364772329623;1042.4996001919121;1050.2753100360878;18012.54968625795;18428.631427371645;18542.721859172394;18628.553871161217;18671.533211669816;48419.27371089507;50595;52612.73693631507;52638.210426844395;52924.47075529196;70582.94125588224;70660;72128.918066228;72131;72730.27269727447;7584.08990921093;7759.107702614046;7801.336886364723;7845.176256493214;7943.364530837634;9162.541872906195;12176.817347739614;12268.570600028956;12552.05859560555;12561.434735436744;10300.639477618548;10619.36283822973;10965.890341096487;10978.780424391307;11234.269772464764;8515.443108806308;10622;10674.519646616076;10917.781644366909;11092.778144436905;10871.130309575057;11223.214374993671;11411.942940285246;11416.257943233662;11431.942840285745;7540.359069478936;7661.540307581563;7730.342920851565;7815.843683126419;8046.1149273578685;10871.184661150288;10926.016658500774;10939.890601093886;11006.284591501526;11085.057770089632 07:09:04 INFO - PROCESS | 1674 | |3;mootools.html;1424.5156646740106;1548.41934274647;1562.7655851622255;1827.7441158237848;1990.9004549772508;6623.470122390209;8455.873161902577;8744.912550874496;8746.650133994632;8756.03683594804;8587.52768597727;8627.137286271385;8739;8751.431156974792;8753.824923501543;2163.0266380129005;2435.5007223519137;2494.6008638617823;2520.4833009233157;2523.7602427769425;2514.396544829246;2517.4335774450783;2521.445282037949;2523.7980961523126;2525.3434107132093;2225.3991422315967;2362.244081893795;2438.6463962725484;2472.443700167466;2488.30327508298;2278.1798552521077;2308.4575124845815;2465.0139944022353;2481.652568640383;2492.9750702493016;2489.7634724701124;2490.150821759711;2509.987450062738;2511.5855883779154;2520;8784.297256219486;8941.552922353856;8942.597583108776;8961.641534338683;8974.50640214788;5448.673079615236;5631.408702086263;5636.098224284095;5655.830325090254;5668.801591944303;3607.0261029522144;3691.3724666806706;3738.065483629093;3744.2324323513612;3762.6801721853676;940.753501610369;1046.0742243114898;1068.172166570906;1078.8813230544633;1081.6160263106563;11932.04543636507;12108.21296615717;12122.757544849143;12132.393380330948;12135.271883687006;4897.216445368724;4957.454679985199;5013.448520662724;5021.121303771825;5033.3205017322925;10226.693199204035;10232.437215953045;10246.282760206863;10252.436116013541;10280;5540.722963851872;5546.91679624806;5547.5007249347755;5552.278203833475;5596.776128954878;4420.668449866273;4536.977315113403;4829.541193586604;4875.756212189376;5028.170351891897;3903.882883513499;3974.0859602291057;3987.4816273884207;4002.8598999035476;4026.416169655384;1125.3248051169232;1313.1530163044783;1317.5191055264759;1323.4375390459015;1323.5103011885665;1346.4546858522315;1348.9055766096278;1383.2253937794867;1396.2809153286066;1414.7099844531847;8116.391270654724;8271.503709777433;8272.8345433091;8289.751307460785;8295.004599448104;461.7279395266021;515.5514702209102;523.481753064471;531.3092979127119;532.4595535531439;6228.47058000066;6239.500839932794;6284.591501552384;6289.113266020176;6293.276273228637;10469.528871200815;10653.987871152229;10707.357558546511;10837.945810270898;10844.240903136704;10378.481075946172;10563.1021363185;10658.495253615394;10660.733481662865;10711;8284.378671599654;8414.789630259293;8461.153884611613;8462.957685211535;8474.66101355939;7884.921150788418;7958.840823183388;7967.163447838126;7973.681052757825;8000.759977200693;9406.341556091282;9472.242220622471;9682.370645907993;9742.561584728846;9769.364991275545;8688.91311086881;9229.215516681157;9810.950945245228;9898.703038908845;9928.056834600702;6732.629705366252;6859.314068593101;7335.229800870832;7502.512336698097;7565.886511702439;8141.755747327589;8177.427580069338;8198.795030124294;8213.014438267446;8213.507189568645;6373.235211774617;7017.964910175417;7265.745698900513;7361.447891408059;7489.700411983677;7137;7164.462665300019;7262.709491620276;7307.196208416964;7351.595662238628;7502.699892004477;7745.883811742716;7762.301392874669;7762.5730584818375;7769.184235655401;6945.756898508528;7045.823854403681;7046.506744527834;7048.577085374894;7048.8590228194125;6875.931240687729;6995.055667484824;7009.894851577333;7021.087258656342;7027.402670773042 07:09:04 INFO - PROCESS | 1674 | |4;prototype.html;310.62569603627634;316.6754077071002;322.4985148094713;324.16204112369525;328.4219773199169;6096.6951652417365;6387.265464471587;6436.710348034344;6462.773802916899;6471.70877310521;6290.308066112724;6376.362363763633;6398.9360106399035;6412.743490260384;6435.581687190341;4517.119161763441;4600.263957766758;4621.768911554425;4634.3280224367445;4762.452317983433;3968.940465893014;4442.422485076935;4626.352310676508;4647.88380290492;4737.976310118444;4656.464506581736;4681.180793361165;4690.991436841078;4692.6245900327895;4700.365450664151;4643.907121857544;4657.278121891079;4665.813367465297;4677.13473007493;4699.78850951708;3777.225668737902;3884.6503814656535;3978.9801050994847;3986.421968814506;4001.5998400160042;5140.280360749498;5891.82163567284;6054.909176362358;6062.454379105858;6072.089186621998;5377.462253774591;5391.973040134813;5392.433794451605;5401.3248343957;5418.106012507931;6712.496562757813;6726.159230096238;6737.19153701554;6744.291849355796;6745.325467453215;4376.649868010583;4378.277584198603;4382.846600368972;4385.912281754347;4388.934165987513;6781.491388145909;7074.469414793911;7166.677499512534;7166.928330716731;7179.856402871966;4420.425344705168;4460.531644177379;4472.306792447176;4483.977580112079;4489.6408287336935;4564.6348292136545;4565;4566.292224705176;4569.360289559464;4572.634189264851;5390.218418329398;5392.218128371364;5392.622516423891;5401.081816091195;5405.540529055074;6804.21751498584;6813.7955861324235;6814.863702725917;6823.249442561314;6829.146356705412;1556.626409661673;1569.6703692224532;1654.8096968848736;1661.7341225403877;1662.9334826607042;1053.2890299048113;1074.7259448840496;1090.5310716392028;1090.8472813806075;1099.8185299425666;5138.845834624967;6152.507799376039;6234.407731265523;6284.842878927972;6327.557071005078;6169.876602467925;6667.933130699162;7094.858102838018;7108.253633368526;7120.964395177991;5674.00704876645;6007.669578173242;6417.9679101605125;6421.614703117828;6426.710798014101;3694.168812017275;3728.496652951871;3741.214344987529;3750.568684601306;3752.7185461090526;7149.428045756431;7418.109826820708;7419;7437.8140546486775;7443.4789564729945;5831.620944638585;5926.555508336805;6386.616802991835;6925.653717314114;7327.37717294036;7354.485186036926;7365.558066516026;7379.631018449163;7385.409167266498;7394.815129621803;7061.435085193275;7080.114985626797;7081.575105493687;7101.680424380812;7108.751193708195;6402.90395644075;6692.464602831665;6960.651967401711;6960.825979350557;6982;6736.966315168393;7362.9631851840395;7375.520591161558;7405.185429602847;7445.888311675438;4670.649701272486;4674.719516829001;4685.390899183084;4686.882827929329;4693.319468677091;6893.620850853251;6998.790036298919;7001.404880585003;7007.8248043797275;7012.929870701431;5575.275214222287;6545.803625891231;6810;6813;6822.3859852613505;6783.152105986752;6816.216135144324;6836.726530938906;6839.6580170990255;6842.863142737217;6618;6631.303713110054;6632.369924857131;6635.701393437404;6636.336366363518;6038.365971573097;6293.874122517433;6791;6807.965960170168;6821.795346139624;6326.6520341381665;6436.195475565554;6642.933570664425;6669.366410191024;6700.497462690415 07:09:04 INFO - PROCESS | 1674 | |5;yui.html;682.5120039171994;687.1204857782039;705.6401235369966;712.3731116617375;763.1833937686674;14922.77615835762;15133.621659458518;15144.469943551978;15155;15160.54518364448;13994.79007814881;15774.369025238977;16212.675746485063;16236.025838449672;16259;742.6064185981438;751.7143485475511;918.8529835226365;928.0533855467419;938.0338251600862;915.1397686175007;934.0985948559638;934.1919239857508;934.4113208678523;935.5415846235363;983.6901376066517;988.2538683294139;992.3748038735587;992.4938281476462;993.3741742702088;764.1899586438366;774.9031371078615;775.8331958628866;970.8301047316727;973.9318247722662;712.8289210589473;726.1467775363926;726.1685370251085;727.0076345787961;727.654364177017;14044.595540445976;15490.845091549052;15516.689666206725;15556;15558.455454059167;10403.791924161551;11863.406829658483;12590.68523286916;12855.550055748097;13109.868901311056;10020.949895250476;10046.497675116289;10074.345167564084;10350.327228730184;10357.585696572203;3404.42124838778;3440.82795860206;3461.567304086989;3461.7749846259912;3517.2437925846066;78948.81576776353;83419;87574.56212718895;88515.55742221313;88839.55580222122;9273.58268877902;9331.953340233391;9345.626174953062;9368.906310936803;9760.170385517169;21779.782202178092;21830.672539911913;21830.89084554567;21831.781682183293;21836;7374.631268436557;7472.402207823361;7499.02512673349;7535;7571.886421703679;4083.14254006656;4102.364133559303;4131.338985762263;4157.355609880473;4425.491068527096;2988.61148050752;3630.6006339302658;3640.4357324614725;3643.4899114124046;3643.6720695137565;589.345826132992;655.4068567946016;657.552864052449;658.940695337422;673.9022841687928;542.6897804978269;589.0927970924813;593.1458699472745;601.3685630088389;608.349066498842;7869.685212591547;8079.798005049804;8192.426530142951;8341.624626891804;8353.749387518385;446.698478526993;579.1717843483774;602.5661523702927;604.9697515124226;630.7477009196358;3270;3751.381735807131;3793.791341476245;3881.5342158940543;3929.0848107331303;92444.53777731203;93141.0685893146;94203;94239.10489398651;94668.52665736765;80134.79797803037;80139.19860801318;80731.19268807236;80994.5950270245;81419.18580814234;71360.2863971364;71795.64102179455;72274;72349.6382518084;72823;7601.3918886487845;7685.577293248702;7722;7756.457048006585;7859.921400786147;46327.07345853131;50564.74717626535;51167.744161278955;51314;53524;65588;69809.3019069823;69956.30043699498;69975;70577.29422705913;9922.801543969224;9962.55168517404;11078.612248571262;11198.776024479303;11302.852458032947;11911.523539058688;11999.165275459016;12017;12254.693632659255;12568.057395695176;11514.712132196762;11553.075753939496;11877.346745929057;12016.75966480683;12048.337341446304;11529;11576;11787.115966302734;11875.13686767107;12138.968187703791;11238.494267757807;11250.66248012561;11340.94329528347;11505.712357190803;11680.532778688757;9301.348905576815;9316.44101353921;9333.533323333942;9885.802283954425;10107.292489525662;8579.598668871899;8912;9098.226650734761;9668.613255469983;9748.463834489172 07:09:04 INFO - PROCESS | 1674 | __end_tp_report 07:09:04 INFO - PROCESS | 1674 | __start_cc_report 07:09:04 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1216 07:09:04 INFO - PROCESS | 1674 | __end_cc_report 07:09:04 INFO - PROCESS | 1674 | __startTimestamp1457964544448__endTimestamp 07:09:04 INFO - PROCESS | 1674 | 07:09:04 INFO - PROCESS | 1674 | ------- Summary: start ------- 07:09:04 INFO - PROCESS | 1674 | Number of tests: 6 07:09:04 INFO - PROCESS | 1674 | 07:09:04 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5660.59 Median:5864.24 stddev:651.22 (11.1%) stddev-sans-first:614.97 07:09:04 INFO - PROCESS | 1674 | Values: 2857.3 3439.2 3445.2 3450.7 3504.5 5499.7 5602.1 5616.3 5623.2 5634.7 5585.2 5592.2 5609.8 5684.3 5705.0 5040.8 5079.3 5092.1 5103.9 5186.9 5159.6 5191.2 5209.5 5209.8 5269.9 5048.6 5083.4 5170.3 5177.0 5208.9 5111.3 5146.2 5153.4 5163.0 5169.7 5095.5 5126.6 5139.7 5154.1 5179.6 5380.0 5474.3 5506.8 5556.4 5564.2 6119.7 6208.2 6214.2 6218.4 6229.3 6177.0 6246.6 6255.2 6261.4 6265.9 4755.9 5571.4 5632.8 5702.2 5746.0 6236.0 6249.9 6255.3 6273.1 6278.2 5669.9 5998.1 6021.4 6033.8 6065.3 6049.1 6139.0 6145.3 6218.2 6238.5 6137.5 6149.9 6152.0 6160.0 6167.3 6183.5 6194.0 6194.9 6197.4 6214.5 4765.3 4802.1 4851.3 4859.5 4911.5 4351.5 4390.8 4394.6 4396.6 4399.6 5568.1 5641.8 5645.8 5646.8 5654.4 6137.9 6140.1 6144.9 6234.6 6283.6 5621.0 5631.8 5637.0 5645.8 5677.3 5262.1 5264.3 5265.9 5266.7 5336.8 6180.9 6197.7 6256.2 6264.5 6276.6 6216.6 6228.3 6240.4 6245.5 6255.8 6145.8 6252.5 6260.0 6262.3 6268.5 6076.9 6101.3 6150.3 6150.5 6159.3 6200.8 6205.1 6221.4 6224.9 6225.3 5908.0 5976.4 6030.8 6046.2 6065.8 6029.3 6038.4 6069.9 6076.5 6112.5 5618.2 5819.6 5854.4 5864.2 5874.6 5783.3 5991.8 6020.8 6039.2 6072.9 4587.8 5027.4 5912.2 5916.5 5935.5 07:09:04 INFO - PROCESS | 1674 | 07:09:04 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:58602.23 Median:38961.80 stddev:120310.17 (308.8%) stddev-sans-first:120568.57 07:09:04 INFO - PROCESS | 1674 | Values: 494.8 512.4 585.7 611.9 633.2 38440.0 39188.6 39227.6 39293.0 39338.6 41921.8 42424.8 42428.6 42469.2 42480.6 9427.9 9656.1 9662.9 9667.5 9736.1 9494.7 9643.9 9645.2 9658.7 9675.5 9750.4 9835.0 9838.9 9842.6 9860.1 9728.1 9806.2 9807.9 9810.4 9828.9 9628.1 9755.4 9757.3 9762.9 9769.2 40989.0 41356.8 41447.8 41514.0 41707.0 3215.4 3219.8 3249.2 3274.5 3483.4 29123.7 29540.0 29585.4 29622.6 29665.0 2732.4 2740.2 2743.3 2749.9 2817.8 479008.0 481712.0 482125.0 482531.0 483643.7 45349.8 65018.0 66542.0 66602.7 66687.0 44734.0 44810.1 44858.3 44869.1 45024.0 15566.3 15790.3 15815.4 15824.8 15836.6 12679.7 12760.4 12771.5 12776.0 12777.6 14699.3 14746.6 14754.8 14836.2 14944.4 6351.1 6510.1 6519.9 6521.5 6572.9 953.1 955.2 963.5 973.6 1006.6 28734.1 29133.7 29166.4 29638.0 29687.4 927.2 1052.1 1102.3 1165.5 1216.0 14047.3 14122.7 14324.3 14346.5 14470.0 519311.0 533163.3 533617.3 535278.0 536398.0 48733.0 57607.4 59220.4 59750.0 59898.0 1178.3 1316.3 1333.1 1429.6 1480.9 28252.0 28411.3 28615.6 28918.0 28949.8 45648.0 46134.8 46589.3 46632.3 46639.5 311617.0 313177.0 314166.0 314213.0 314759.0 28429.3 32880.0 33762.0 33763.5 33826.5 42194.7 44124.8 44235.6 44279.3 44889.7 33529.7 34328.7 36046.7 36580.3 36590.6 35539.8 35694.0 35710.8 36605.0 36763.0 36564.8 36794.3 36815.3 38108.4 38735.0 29979.7 30818.0 31381.8 31477.8 31481.7 19729.5 21519.0 24427.8 24956.0 24968.4 07:09:04 INFO - PROCESS | 1674 | 07:09:04 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:34183.33 Median:21652.12 stddev:101297.10 (467.8%) stddev-sans-first:101549.39 07:09:04 INFO - PROCESS | 1674 | Values: 336.2 362.5 363.9 365.2 373.6 15853.7 19601.6 20242.9 20921.4 20927.1 19351.5 19631.2 20314.9 20321.6 20377.9 5714.9 5881.1 5936.7 5937.0 5937.7 4221.4 4389.4 5755.8 6165.9 6383.9 6315.7 6331.1 6336.7 6337.5 6351.1 6123.9 6208.4 6275.8 6297.3 6312.3 3705.1 5198.8 5425.5 5442.8 5456.3 23698.4 24509.0 24581.4 24619.4 24690.3 1751.7 2120.1 2133.7 2197.3 2566.7 14073.0 14296.0 14535.0 14845.3 14981.5 1681.9 1753.3 1786.6 1791.2 1833.7 88367.7 92220.0 99950.5 104507.5 104730.5 10182.3 10366.7 10613.5 10633.5 10745.9 10771.9 12726.5 12794.0 12799.3 12830.7 8278.4 8303.0 8376.7 8603.0 8690.5 8930.4 8930.7 8956.0 9034.2 9052.5 5119.5 6077.8 6185.8 6187.5 6260.2 1665.3 1672.2 1746.6 1750.0 1774.7 891.7 928.7 1002.8 1033.2 1051.0 21105.9 21512.4 21590.5 21713.8 21835.3 928.6 967.4 1022.8 1057.6 1076.1 11125.7 11498.2 11532.9 11555.7 11617.4 560694.0 614963.0 624563.0 629907.0 630641.0 110207.0 112070.0 112533.4 113181.4 114725.0 996.4 1011.2 1038.6 1042.5 1050.3 18012.5 18428.6 18542.7 18628.6 18671.5 48419.3 50595.0 52612.7 52638.2 52924.5 70582.9 70660.0 72128.9 72131.0 72730.3 7584.1 7759.1 7801.3 7845.2 7943.4 9162.5 12176.8 12268.6 12552.1 12561.4 10300.6 10619.4 10965.9 10978.8 11234.3 8515.4 10622.0 10674.5 10917.8 11092.8 10871.1 11223.2 11411.9 11416.3 11431.9 7540.4 7661.5 7730.3 7815.8 8046.1 10871.2 10926.0 10939.9 11006.3 11085.1 07:09:04 INFO - PROCESS | 1674 | 07:09:04 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:6047.18 Median:5543.82 stddev:3202.17 (57.8%) stddev-sans-first:3192.30 07:09:04 INFO - PROCESS | 1674 | Values: 1424.5 1548.4 1562.8 1827.7 1990.9 6623.5 8455.9 8744.9 8746.7 8756.0 8587.5 8627.1 8739.0 8751.4 8753.8 2163.0 2435.5 2494.6 2520.5 2523.8 2514.4 2517.4 2521.4 2523.8 2525.3 2225.4 2362.2 2438.6 2472.4 2488.3 2278.2 2308.5 2465.0 2481.7 2493.0 2489.8 2490.2 2510.0 2511.6 2520.0 8784.3 8941.6 8942.6 8961.6 8974.5 5448.7 5631.4 5636.1 5655.8 5668.8 3607.0 3691.4 3738.1 3744.2 3762.7 940.8 1046.1 1068.2 1078.9 1081.6 11932.0 12108.2 12122.8 12132.4 12135.3 4897.2 4957.5 5013.4 5021.1 5033.3 10226.7 10232.4 10246.3 10252.4 10280.0 5540.7 5546.9 5547.5 5552.3 5596.8 4420.7 4537.0 4829.5 4875.8 5028.2 3903.9 3974.1 3987.5 4002.9 4026.4 1125.3 1313.2 1317.5 1323.4 1323.5 1346.5 1348.9 1383.2 1396.3 1414.7 8116.4 8271.5 8272.8 8289.8 8295.0 461.7 515.6 523.5 531.3 532.5 6228.5 6239.5 6284.6 6289.1 6293.3 10469.5 10654.0 10707.4 10837.9 10844.2 10378.5 10563.1 10658.5 10660.7 10711.0 8284.4 8414.8 8461.2 8463.0 8474.7 7884.9 7958.8 7967.2 7973.7 8000.8 9406.3 9472.2 9682.4 9742.6 9769.4 8688.9 9229.2 9811.0 9898.7 9928.1 6732.6 6859.3 7335.2 7502.5 7565.9 8141.8 8177.4 8198.8 8213.0 8213.5 6373.2 7018.0 7265.7 7361.4 7489.7 7137.0 7164.5 7262.7 7307.2 7351.6 7502.7 7745.9 7762.3 7762.6 7769.2 6945.8 7045.8 7046.5 7048.6 7048.9 6875.9 6995.1 7009.9 7021.1 7027.4 07:09:04 INFO - PROCESS | 1674 | 07:09:04 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:5520.75 Median:6259.63 stddev:1746.77 (27.9%) stddev-sans-first:1707.33 07:09:04 INFO - PROCESS | 1674 | Values: 310.6 316.7 322.5 324.2 328.4 6096.7 6387.3 6436.7 6462.8 6471.7 6290.3 6376.4 6398.9 6412.7 6435.6 4517.1 4600.3 4621.8 4634.3 4762.5 3968.9 4442.4 4626.4 4647.9 4738.0 4656.5 4681.2 4691.0 4692.6 4700.4 4643.9 4657.3 4665.8 4677.1 4699.8 3777.2 3884.7 3979.0 3986.4 4001.6 5140.3 5891.8 6054.9 6062.5 6072.1 5377.5 5392.0 5392.4 5401.3 5418.1 6712.5 6726.2 6737.2 6744.3 6745.3 4376.6 4378.3 4382.8 4385.9 4388.9 6781.5 7074.5 7166.7 7166.9 7179.9 4420.4 4460.5 4472.3 4484.0 4489.6 4564.6 4565.0 4566.3 4569.4 4572.6 5390.2 5392.2 5392.6 5401.1 5405.5 6804.2 6813.8 6814.9 6823.2 6829.1 1556.6 1569.7 1654.8 1661.7 1662.9 1053.3 1074.7 1090.5 1090.8 1099.8 5138.8 6152.5 6234.4 6284.8 6327.6 6169.9 6667.9 7094.9 7108.3 7121.0 5674.0 6007.7 6418.0 6421.6 6426.7 3694.2 3728.5 3741.2 3750.6 3752.7 7149.4 7418.1 7419.0 7437.8 7443.5 5831.6 5926.6 6386.6 6925.7 7327.4 7354.5 7365.6 7379.6 7385.4 7394.8 7061.4 7080.1 7081.6 7101.7 7108.8 6402.9 6692.5 6960.7 6960.8 6982.0 6737.0 7363.0 7375.5 7405.2 7445.9 4670.6 4674.7 4685.4 4686.9 4693.3 6893.6 6998.8 7001.4 7007.8 7012.9 5575.3 6545.8 6810.0 6813.0 6822.4 6783.2 6816.2 6836.7 6839.7 6842.9 6618.0 6631.3 6632.4 6635.7 6636.3 6038.4 6293.9 6791.0 6808.0 6821.8 6326.7 6436.2 6642.9 6669.4 6700.5 07:09:04 INFO - PROCESS | 1674 | 07:09:04 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:18697.57 Median:33121.70 stddev:26531.81 (80.1%) stddev-sans-first:26571.75 07:09:04 INFO - PROCESS | 1674 | Values: 682.5 687.1 705.6 712.4 763.2 14922.8 15133.6 15144.5 15155.0 15160.5 13994.8 15774.4 16212.7 16236.0 16259.0 742.6 751.7 918.9 928.1 938.0 915.1 934.1 934.2 934.4 935.5 983.7 988.3 992.4 992.5 993.4 764.2 774.9 775.8 970.8 973.9 712.8 726.1 726.2 727.0 727.7 14044.6 15490.8 15516.7 15556.0 15558.5 10403.8 11863.4 12590.7 12855.6 13109.9 10020.9 10046.5 10074.3 10350.3 10357.6 3404.4 3440.8 3461.6 3461.8 3517.2 78948.8 83419.0 87574.6 88515.6 88839.6 9273.6 9332.0 9345.6 9368.9 9760.2 21779.8 21830.7 21830.9 21831.8 21836.0 7374.6 7472.4 7499.0 7535.0 7571.9 4083.1 4102.4 4131.3 4157.4 4425.5 2988.6 3630.6 3640.4 3643.5 3643.7 589.3 655.4 657.6 658.9 673.9 542.7 589.1 593.1 601.4 608.3 7869.7 8079.8 8192.4 8341.6 8353.7 446.7 579.2 602.6 605.0 630.7 3270.0 3751.4 3793.8 3881.5 3929.1 92444.5 93141.1 94203.0 94239.1 94668.5 80134.8 80139.2 80731.2 80994.6 81419.2 71360.3 71795.6 72274.0 72349.6 72823.0 7601.4 7685.6 7722.0 7756.5 7859.9 46327.1 50564.7 51167.7 51314.0 53524.0 65588.0 69809.3 69956.3 69975.0 70577.3 9922.8 9962.6 11078.6 11198.8 11302.9 11911.5 11999.2 12017.0 12254.7 12568.1 11514.7 11553.1 11877.3 12016.8 12048.3 11529.0 11576.0 11787.1 11875.1 12139.0 11238.5 11250.7 11340.9 11505.7 11680.5 9301.3 9316.4 9333.5 9885.8 10107.3 8579.6 8912.0 9098.2 9668.6 9748.5 07:09:04 INFO - PROCESS | 1674 | -------- Summary: end -------- 07:09:04 INFO - PROCESS | 1674 | 07:09:05 INFO - TEST-INFO | 1674: exit 0 07:09:05 INFO - TEST-OK | dromaeo_css | took 1112920ms 07:09:05 INFO - TEST-START | kraken 07:09:05 INFO - operating with platform_type : mac_ 07:09:05 INFO - Initialising browser for kraken test... 07:09:05 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpB6rF7B/profile http://localhost:49273/getInfo.html) 07:09:07 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 07:09:07 INFO - PROCESS | 1681 | colorDepth:24 07:09:07 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 07:09:07 INFO - PROCESS | 1681 | __metrics 07:09:07 INFO - PROCESS | 1681 | 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" 07:09:07 ERROR - PROCESS | 1681 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:09:08 INFO - TEST-INFO | 1681: exit 0 07:09:08 INFO - Browser initialized. 07:09:08 INFO - Running cycle 1/1 for kraken test... 07:09:08 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpB6rF7B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:20 INFO - PROCESS | 1683 | RSS: Main: 243277824 07:09:20 INFO - PROCESS | 1683 | 07:09:22 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 07:09:23 INFO - PROCESS | 1683 | RSS: Main: 291307520 07:09:23 INFO - PROCESS | 1683 | 07:09:26 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 07:09:26 INFO - PROCESS | 1683 | RSS: Main: 299687936 07:09:26 INFO - PROCESS | 1683 | 07:09:32 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 07:09:32 INFO - PROCESS | 1683 | RSS: Main: 287051776 07:09:32 INFO - PROCESS | 1683 | 07:09:34 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 07:09:35 INFO - PROCESS | 1683 | RSS: Main: 291307520 07:09:35 INFO - PROCESS | 1683 | 07:09:37 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:09:38 INFO - PROCESS | 1683 | RSS: Main: 291749888 07:09:38 INFO - PROCESS | 1683 | 07:09:40 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 07:09:41 INFO - PROCESS | 1683 | RSS: Main: 290713600 07:09:41 INFO - PROCESS | 1683 | 07:09:44 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 07:09:45 INFO - PROCESS | 1683 | RSS: Main: 289251328 07:09:45 INFO - PROCESS | 1683 | 07:09:48 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 07:09:48 INFO - PROCESS | 1683 | RSS: Main: 290623488 07:09:48 INFO - PROCESS | 1683 | 07:09:50 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:09:51 INFO - PROCESS | 1683 | RSS: Main: 325742592 07:09:51 INFO - PROCESS | 1683 | 07:09:52 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:09:53 INFO - PROCESS | 1683 | RSS: Main: 325578752 07:09:53 INFO - PROCESS | 1683 | 07:09:55 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:09:56 INFO - PROCESS | 1683 | RSS: Main: 332206080 07:09:56 INFO - PROCESS | 1683 | 07:09:58 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:09:59 INFO - PROCESS | 1683 | RSS: Main: 334069760 07:09:59 INFO - PROCESS | 1683 | 07:10:01 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:10:02 INFO - PROCESS | 1683 | RSS: Main: 333111296 07:10:02 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 07:10:04 INFO - PROCESS | 1683 | RSS: Main: 393461760 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | __start_tp_report 07:10:04 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 07:10:04 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 07:10:04 INFO - PROCESS | 1683 | |i|pagename|runs| 07:10:04 INFO - PROCESS | 1683 | |0;ai-astar;112;110;109;111;112;112;116;114;157;167 07:10:04 INFO - PROCESS | 1683 | |1;audio-beat-detection;156;125;178;190;120;140;139;113;158;122 07:10:04 INFO - PROCESS | 1683 | |2;audio-dft;383;384;388;383;382;379;382;385;383;386 07:10:04 INFO - PROCESS | 1683 | |3;audio-fft;78;73;85;78;72;83;83;102;73;44 07:10:04 INFO - PROCESS | 1683 | |4;audio-oscillator;95;99;126;81;78;81;110;76;80;108 07:10:04 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;89;86;89;86;88;84;89;84;89;86 07:10:04 INFO - PROCESS | 1683 | |6;imaging-darkroom;156;158;159;160;157;172;195;159;157;158 07:10:04 INFO - PROCESS | 1683 | |7;imaging-desaturate;84;88;86;86;86;96;86;86;87;87 07:10:04 INFO - PROCESS | 1683 | |8;json-parse-financial;57;56;55;53;55;54;53;79;81;81 07:10:04 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;62;61;73;72;70;65;65;66;66;67 07:10:04 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;83;83;85;97;110;107;81;83;85;83 07:10:04 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;123;145;139;107;124;133;130;136;123;129 07:10:04 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;125;124;136;123;138;127;136;137;135;138 07:10:04 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;65;65;63;65;67;67;68;67;67;66 07:10:04 INFO - PROCESS | 1683 | __end_tp_report 07:10:04 INFO - PROCESS | 1683 | __start_cc_report 07:10:04 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1247 07:10:04 INFO - PROCESS | 1683 | __end_cc_report 07:10:04 INFO - PROCESS | 1683 | __startTimestamp1457964604353__endTimestamp 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | ------- Summary: start ------- 07:10:04 INFO - PROCESS | 1683 | Number of tests: 14 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:122.00 Median:113.00 stddev:21.30 (18.9%) stddev-sans-first:22.28 07:10:04 INFO - PROCESS | 1683 | Values: 112.0 110.0 109.0 111.0 112.0 112.0 116.0 114.0 157.0 167.0 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:148.00 stddev:25.89 (17.5%) stddev-sans-first:27.11 07:10:04 INFO - PROCESS | 1683 | Values: 156.0 125.0 178.0 190.0 120.0 140.0 139.0 113.0 158.0 122.0 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:383.50 Median:383.50 stddev:2.46 (0.6%) stddev-sans-first:2.60 07:10:04 INFO - PROCESS | 1683 | Values: 383.0 384.0 388.0 383.0 382.0 379.0 382.0 385.0 383.0 386.0 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:77.10 Median:78.00 stddev:14.56 (18.7%) stddev-sans-first:15.44 07:10:04 INFO - PROCESS | 1683 | Values: 78.0 73.0 85.0 78.0 72.0 83.0 83.0 102.0 73.0 44.0 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:80.50 stddev:17.04 (21.2%) stddev-sans-first:18.06 07:10:04 INFO - PROCESS | 1683 | Values: 95.0 99.0 126.0 81.0 78.0 81.0 110.0 76.0 80.0 108.0 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.50 stddev:2.05 (2.3%) stddev-sans-first:2.05 07:10:04 INFO - PROCESS | 1683 | Values: 89.0 86.0 89.0 86.0 88.0 84.0 89.0 84.0 89.0 86.0 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:163.10 Median:159.00 stddev:12.10 (7.6%) stddev-sans-first:12.55 07:10:04 INFO - PROCESS | 1683 | Values: 156.0 158.0 159.0 160.0 157.0 172.0 195.0 159.0 157.0 158.0 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:87.20 Median:86.50 stddev:3.26 (3.8%) stddev-sans-first:3.24 07:10:04 INFO - PROCESS | 1683 | Values: 84.0 88.0 86.0 86.0 86.0 96.0 86.0 86.0 87.0 87.0 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:56.50 stddev:12.45 (22.0%) stddev-sans-first:13.05 07:10:04 INFO - PROCESS | 1683 | Values: 57.0 56.0 55.0 53.0 55.0 54.0 53.0 79.0 81.0 81.0 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.50 stddev:3.95 (5.9%) stddev-sans-first:3.80 07:10:04 INFO - PROCESS | 1683 | Values: 62.0 61.0 73.0 72.0 70.0 65.0 65.0 66.0 66.0 67.0 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:83.00 stddev:10.87 (13.1%) stddev-sans-first:11.26 07:10:04 INFO - PROCESS | 1683 | Values: 83.0 83.0 85.0 97.0 110.0 107.0 81.0 83.0 85.0 83.0 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:131.50 stddev:10.56 (8.0%) stddev-sans-first:10.98 07:10:04 INFO - PROCESS | 1683 | Values: 123.0 145.0 139.0 107.0 124.0 133.0 130.0 136.0 123.0 129.0 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.90 Median:136.00 stddev:6.30 (4.6%) stddev-sans-first:6.16 07:10:04 INFO - PROCESS | 1683 | Values: 125.0 124.0 136.0 123.0 138.0 127.0 136.0 137.0 135.0 138.0 07:10:04 INFO - PROCESS | 1683 | 07:10:04 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:67.00 stddev:1.49 (2.2%) stddev-sans-first:1.54 07:10:04 INFO - PROCESS | 1683 | Values: 65.0 65.0 63.0 65.0 67.0 67.0 68.0 67.0 67.0 66.0 07:10:04 INFO - PROCESS | 1683 | -------- Summary: end -------- 07:10:04 INFO - PROCESS | 1683 | 07:10:05 INFO - TEST-INFO | 1683: exit 0 07:10:05 INFO - TEST-OK | kraken | took 60016ms 07:10:05 INFO - SUITE-END | took 1172s 07:10:05 INFO - Completed test suite (00:19:33) 07:10:05 INFO - javascript benchmark 07:10:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2857.328527795968, 3439.2433664593796, 3445.1559367954856, 3450.689437950584, 3504.5093686883843, 5499.670019798805, 5602.131669591215, 5616.297962754656, 5623.156526521018, 5634.690092044936, 5585.218069470277, 5592.189132575774, 5609.80365687201, 5684.261046064016, 5705.001624715668, 5040.798368065273, 5079.339685840845, 5092.057969275677, 5103.923441148386, 5186.92219616706, 5159.5614372778355, 5191.169412893919, 5209.505097015796, 5209.791608335662, 5269.8946021079555, 5048.621353398491, 5083.415407228179, 5170.3278573785165, 5177.016366890279, 5208.947910520922, 5111.284420181178, 5146.228065790124, 5153.433122356538, 5162.967406518674, 5169.663971841818, 5095.515925987025, 5126.641135120543, 5139.717315547643, 5154.123798954187, 5179.585633149339, 5380.0, 5474.343078830566, 5506.752196151183, 5556.444355564452, 5564.1931919871395, 6119.694015299217, 6208.192934918477, 6214.192155019864, 6218.378162183745, 6229.345918678564, 6177.0, 6246.593971391891, 6255.218097737783, 6261.405166509175, 6265.906011409833, 4755.857324280277, 5571.387147413781, 5632.802851900205, 5702.2301989231755, 5746.02317606008, 6236.0, 6249.9062514062325, 6255.280642726054, 6273.0904018917, 6278.215223097113, 5669.943300567024, 5998.070299103646, 6021.3677563856045, 6033.7586496540525, 6065.332813390523, 6049.122877182872, 6138.970878344271, 6145.324014358417, 6218.160548325918, 6238.532110091761, 6137.4689182037, 6149.877002459926, 6152.0, 6160.0, 6167.259928808482, 6183.536234782409, 6194.008958566607, 6194.853952018891, 6197.380261973766, 6214.5028397728975, 4765.309030190603, 4802.135615589227, 4851.272309153655, 4859.514048595183, 4911.484294149134, 4351.521332653406, 4390.8024138913825, 4394.582514661102, 4396.648268138541, 4399.62603178727, 5568.081266590967, 5641.802536911188, 5645.830625081254, 5646.802361917313, 5654.4062873398525, 6137.8979746733885, 6140.13616995768, 6144.907826382608, 6234.5635805494085, 6283.59156654816, 5621.0444224481935, 5631.802886898939, 5637.041702910515, 5645.830625081254, 5677.347105082886, 5262.052830490472, 5264.341957255343, 5265.868353291198, 5266.657667251617, 5336.813211537577, 6180.938190618036, 6197.659128747962, 6256.155419018374, 6264.467520260738, 6276.560640755195, 6216.564840461125, 6228.252609686867, 6240.375962403723, 6245.531585131042, 6255.812325630239, 6145.801568694062, 6252.468540174136, 6260.0, 6262.3111457738705, 6268.4671802897265, 6076.878462430638, 6101.328853826164, 6150.292716337678, 6150.477209437069, 6159.29168145669, 6200.782972595937, 6205.069239614094, 6221.377862213742, 6224.906626400517, 6225.252969643671, 5908.0, 5976.402359763989, 6030.75876964934, 6046.183765191643, 6065.848353791191, 6029.306629737636, 6038.426349496791, 6069.9089513656445, 6076.513878889767, 6112.510999119971, 5618.213450116905, 5819.5635327351465, 5854.356020837789, 5864.237649105589, 5874.647521148745, 5783.306003279633, 5991.820245392645, 6020.819375418744, 6039.214902062704, 6072.8785424292155, 4587.816487340469, 5027.396712394536, 5912.231409916683, 5916.526677865846, 5935.465808077293], "unit": "score", "name": "dojo.html", "value": 5618.733375378537}, {"lowerIsBetter": false, "replicates": [494.8445380037612, 512.423523536022, 585.7406575861896, 611.9326874043855, 633.1800318587428, 38440.0, 39188.60811391885, 39227.60772392275, 39293.017674558185, 39338.60661393385, 41921.79039104808, 42424.787876060655, 42428.57571424285, 42469.150616987645, 42480.57519424805, 9427.858582121256, 9656.130948214659, 9662.903370966305, 9667.516624168764, 9736.123748862601, 9494.71515854522, 9643.90356096437, 9645.22838172948, 9658.661946831862, 9675.467849268287, 9750.36622619531, 9835.01649835018, 9838.90161098387, 9842.60629574816, 9860.11258986691, 9728.075832795874, 9806.215502759762, 9807.90192098077, 9810.362326448758, 9828.852567211497, 9628.085331893459, 9755.365901216399, 9757.268204884662, 9762.853557196648, 9769.169620582259, 40989.0, 41356.79321603403, 41447.792761036, 41514.0, 41707.0, 3215.3569286142865, 3219.7585181111513, 3249.203945033482, 3274.476083826576, 3483.425234836249, 29123.708762912313, 29539.966101186354, 29585.408291834043, 29622.555661664876, 29665.0, 2732.385213327005, 2740.2464322311325, 2743.341598016462, 2749.9037533686223, 2817.7745780337523, 479008.0, 481712.0, 482125.0, 482531.0, 483643.74534382013, 45349.773251133534, 65018.0, 66542.0, 66602.66698666476, 66686.99969500462, 44734.0, 44810.10379792451, 44858.32712509315, 44869.10261794746, 45024.0, 15566.299516521784, 15790.289436975363, 15815.36738530469, 15824.76262856058, 15836.604084897739, 12679.746405071846, 12760.425780839885, 12771.489140434465, 12776.0, 12777.616671499869, 14699.26503674812, 14746.557603271918, 14754.778678319833, 14836.18400987956, 14944.40222391114, 6351.110844481776, 6510.08858759774, 6519.934800652028, 6521.5108866834225, 6572.86854262912, 953.1326492891435, 955.2024059910053, 963.4556475591269, 973.5813600152003, 1006.6074231049896, 28734.137975860758, 29133.708662913523, 29166.416671666448, 29638.0, 29687.406251874843, 927.1701826864918, 1052.1267348101057, 1102.3000394749392, 1165.4813607944384, 1215.969600759988, 14047.297635118202, 14122.71754564903, 14324.283785810669, 14346.500318877494, 14470.0, 519311.0, 533163.3341833344, 533617.3319133379, 535278.0, 536398.0, 48733.0, 57607.423925761046, 59220.40779592149, 59750.0, 59898.0, 1178.2871362825367, 1316.2628927800463, 1333.0668532027619, 1429.635442962038, 1480.851914808532, 28252.011179608617, 28411.289717757223, 28615.570766438104, 28918.0, 28949.84200631951, 45648.0, 46134.76932615315, 46589.3011604833, 46632.30051549162, 46639.53360466352, 311617.0, 313177.0, 314166.0, 314213.0, 314759.0, 28429.289267768472, 32880.0, 33762.0, 33763.493547597296, 33826.49260261147, 42194.72193230879, 44124.77937610292, 44235.55764442314, 44279.335809962235, 44889.73547512981, 33529.66470335265, 34328.656713432545, 36046.73836415713, 36580.26839463143, 36590.63409365872, 35539.82230088833, 35694.0, 35710.8214458926, 36605.0, 36763.0, 36564.81717591395, 36794.29688398303, 36815.26369472542, 38108.42837357497, 38735.0, 29979.702232754815, 30818.0, 31381.843090785314, 31477.8426107868, 31481.740730371446, 19729.506762331057, 21519.0, 24427.75572244326, 24956.0, 24968.375790604652], "unit": "score", "name": "ext.html", "value": 18882.3856733519}, {"lowerIsBetter": false, "replicates": [336.1695567634232, 362.4689829399929, 363.91629925117223, 365.21478820535845, 373.5554689918998, 15853.68292634148, 19601.607967840635, 20242.886641234727, 20921.372358829223, 20927.058282377293, 19351.516212094706, 19631.214751409963, 20314.89842550789, 20321.59356812863, 20377.898110509464, 5714.857128571788, 5881.088431293135, 5936.673482958436, 5936.970315148418, 5937.732802023897, 4221.387898754679, 4389.363542286366, 5755.798547050854, 6165.907511387333, 6383.946648802965, 6315.684215789192, 6331.113644089831, 6336.651484168369, 6337.524685648595, 6351.110844481776, 6123.877522449548, 6208.379162083801, 6275.843103922392, 6297.33877942814, 6312.3372045934975, 3705.110773414388, 5198.792048318101, 5425.457454254582, 5442.782288708447, 5456.317960254968, 23698.40753981147, 24509.0, 24581.38546536333, 24619.384515387257, 24690.25929222126, 1751.7372394140853, 2120.0883620043373, 2133.7332833395826, 2197.3407977606653, 2566.7304932981956, 14073.0, 14295.9992800504, 14535.0, 14845.331960061716, 14981.475648352256, 1681.9327226911032, 1753.289917583368, 1786.553361659585, 1791.1581556668345, 1833.7432759413693, 88367.67448488278, 92220.0, 99950.50024749902, 104507.4774626122, 104730.47634761853, 10182.338148020355, 10366.740831479123, 10613.5223914924, 10633.46832658364, 10745.892541074645, 10771.946140269249, 12726.490940362282, 12794.040446966515, 12799.29603871796, 12830.743385132246, 8278.379121565908, 8303.0, 8376.706815261437, 8602.956985215034, 8690.522021288889, 8930.419522731001, 8930.732078037669, 8956.0, 9034.186923176945, 9052.502112383881, 5119.48805119485, 6077.787277445268, 6185.752569897154, 6187.504999600022, 6260.217472815898, 1665.300573759024, 1672.1889883406539, 1746.56335916021, 1749.9850086949539, 1774.698301288784, 891.7458524320667, 928.6749637626912, 1002.8295189817749, 1033.2405681823852, 1051.01687367015, 21105.944702764802, 21512.354629361143, 21590.460238494165, 21713.78286217149, 21835.344939651837, 928.6007016982762, 967.4388854464394, 1022.8005538919988, 1057.5558265528496, 1076.0799516413354, 11125.666230013112, 11498.195126341076, 11532.88467115335, 11555.711107222218, 11617.419129043514, 560694.0, 614963.0, 624563.0, 629907.0, 630641.0, 110207.0, 112070.0, 112533.43733281444, 113181.434092829, 114725.0, 996.4170959988343, 1011.1506334678758, 1038.6364772329623, 1042.4996001919121, 1050.2753100360878, 18012.54968625795, 18428.631427371645, 18542.721859172394, 18628.553871161217, 18671.533211669816, 48419.27371089507, 50595.0, 52612.73693631507, 52638.210426844395, 52924.47075529196, 70582.94125588224, 70660.0, 72128.918066228, 72131.0, 72730.27269727447, 7584.08990921093, 7759.107702614046, 7801.336886364723, 7845.176256493214, 7943.364530837634, 9162.541872906195, 12176.817347739614, 12268.570600028956, 12552.05859560555, 12561.434735436744, 10300.639477618548, 10619.36283822973, 10965.890341096487, 10978.780424391307, 11234.269772464764, 8515.443108806308, 10622.0, 10674.519646616076, 10917.781644366909, 11092.778144436905, 10871.130309575057, 11223.214374993671, 11411.942940285246, 11416.257943233662, 11431.942840285745, 7540.359069478936, 7661.540307581563, 7730.342920851565, 7815.843683126419, 8046.1149273578685, 10871.184661150288, 10926.016658500774, 10939.890601093886, 11006.284591501526, 11085.057770089632], "unit": "score", "name": "jquery.html", "value": 9467.666550004467}, {"lowerIsBetter": false, "replicates": [1424.5156646740106, 1548.41934274647, 1562.7655851622255, 1827.7441158237848, 1990.9004549772508, 6623.470122390209, 8455.873161902577, 8744.912550874496, 8746.650133994632, 8756.03683594804, 8587.52768597727, 8627.137286271385, 8739.0, 8751.431156974792, 8753.824923501543, 2163.0266380129005, 2435.5007223519137, 2494.6008638617823, 2520.4833009233157, 2523.7602427769425, 2514.396544829246, 2517.4335774450783, 2521.445282037949, 2523.7980961523126, 2525.3434107132093, 2225.3991422315967, 2362.244081893795, 2438.6463962725484, 2472.443700167466, 2488.30327508298, 2278.1798552521077, 2308.4575124845815, 2465.0139944022353, 2481.652568640383, 2492.9750702493016, 2489.7634724701124, 2490.150821759711, 2509.987450062738, 2511.5855883779154, 2520.0, 8784.297256219486, 8941.552922353856, 8942.597583108776, 8961.641534338683, 8974.50640214788, 5448.673079615236, 5631.408702086263, 5636.098224284095, 5655.830325090254, 5668.801591944303, 3607.0261029522144, 3691.3724666806706, 3738.065483629093, 3744.2324323513612, 3762.6801721853676, 940.753501610369, 1046.0742243114898, 1068.172166570906, 1078.8813230544633, 1081.6160263106563, 11932.04543636507, 12108.21296615717, 12122.757544849143, 12132.393380330948, 12135.271883687006, 4897.216445368724, 4957.454679985199, 5013.448520662724, 5021.121303771825, 5033.3205017322925, 10226.693199204035, 10232.437215953045, 10246.282760206863, 10252.436116013541, 10280.0, 5540.722963851872, 5546.91679624806, 5547.5007249347755, 5552.278203833475, 5596.776128954878, 4420.668449866273, 4536.977315113403, 4829.541193586604, 4875.756212189376, 5028.170351891897, 3903.882883513499, 3974.0859602291057, 3987.4816273884207, 4002.8598999035476, 4026.416169655384, 1125.3248051169232, 1313.1530163044783, 1317.5191055264759, 1323.4375390459015, 1323.5103011885665, 1346.4546858522315, 1348.9055766096278, 1383.2253937794867, 1396.2809153286066, 1414.7099844531847, 8116.391270654724, 8271.503709777433, 8272.8345433091, 8289.751307460785, 8295.004599448104, 461.7279395266021, 515.5514702209102, 523.481753064471, 531.3092979127119, 532.4595535531439, 6228.47058000066, 6239.500839932794, 6284.591501552384, 6289.113266020176, 6293.276273228637, 10469.528871200815, 10653.987871152229, 10707.357558546511, 10837.945810270898, 10844.240903136704, 10378.481075946172, 10563.1021363185, 10658.495253615394, 10660.733481662865, 10711.0, 8284.378671599654, 8414.789630259293, 8461.153884611613, 8462.957685211535, 8474.66101355939, 7884.921150788418, 7958.840823183388, 7967.163447838126, 7973.681052757825, 8000.759977200693, 9406.341556091282, 9472.242220622471, 9682.370645907993, 9742.561584728846, 9769.364991275545, 8688.91311086881, 9229.215516681157, 9810.950945245228, 9898.703038908845, 9928.056834600702, 6732.629705366252, 6859.314068593101, 7335.229800870832, 7502.512336698097, 7565.886511702439, 8141.755747327589, 8177.427580069338, 8198.795030124294, 8213.014438267446, 8213.507189568645, 6373.235211774617, 7017.964910175417, 7265.745698900513, 7361.447891408059, 7489.700411983677, 7137.0, 7164.462665300019, 7262.709491620276, 7307.196208416964, 7351.595662238628, 7502.699892004477, 7745.883811742716, 7762.301392874669, 7762.5730584818375, 7769.184235655401, 6945.756898508528, 7045.823854403681, 7046.506744527834, 7048.577085374894, 7048.8590228194125, 6875.931240687729, 6995.055667484824, 7009.894851577333, 7021.087258656342, 7027.402670773042], "unit": "score", "name": "mootools.html", "value": 4852.965153281881}, {"lowerIsBetter": false, "replicates": [310.62569603627634, 316.6754077071002, 322.4985148094713, 324.16204112369525, 328.4219773199169, 6096.6951652417365, 6387.265464471587, 6436.710348034344, 6462.773802916899, 6471.70877310521, 6290.308066112724, 6376.362363763633, 6398.9360106399035, 6412.743490260384, 6435.581687190341, 4517.119161763441, 4600.263957766758, 4621.768911554425, 4634.3280224367445, 4762.452317983433, 3968.940465893014, 4442.422485076935, 4626.352310676508, 4647.88380290492, 4737.976310118444, 4656.464506581736, 4681.180793361165, 4690.991436841078, 4692.6245900327895, 4700.365450664151, 4643.907121857544, 4657.278121891079, 4665.813367465297, 4677.13473007493, 4699.78850951708, 3777.225668737902, 3884.6503814656535, 3978.9801050994847, 3986.421968814506, 4001.5998400160042, 5140.280360749498, 5891.82163567284, 6054.909176362358, 6062.454379105858, 6072.089186621998, 5377.462253774591, 5391.973040134813, 5392.433794451605, 5401.3248343957, 5418.106012507931, 6712.496562757813, 6726.159230096238, 6737.19153701554, 6744.291849355796, 6745.325467453215, 4376.649868010583, 4378.277584198603, 4382.846600368972, 4385.912281754347, 4388.934165987513, 6781.491388145909, 7074.469414793911, 7166.677499512534, 7166.928330716731, 7179.856402871966, 4420.425344705168, 4460.531644177379, 4472.306792447176, 4483.977580112079, 4489.6408287336935, 4564.6348292136545, 4565.0, 4566.292224705176, 4569.360289559464, 4572.634189264851, 5390.218418329398, 5392.218128371364, 5392.622516423891, 5401.081816091195, 5405.540529055074, 6804.21751498584, 6813.7955861324235, 6814.863702725917, 6823.249442561314, 6829.146356705412, 1556.626409661673, 1569.6703692224532, 1654.8096968848736, 1661.7341225403877, 1662.9334826607042, 1053.2890299048113, 1074.7259448840496, 1090.5310716392028, 1090.8472813806075, 1099.8185299425666, 5138.845834624967, 6152.507799376039, 6234.407731265523, 6284.842878927972, 6327.557071005078, 6169.876602467925, 6667.933130699162, 7094.858102838018, 7108.253633368526, 7120.964395177991, 5674.00704876645, 6007.669578173242, 6417.9679101605125, 6421.614703117828, 6426.710798014101, 3694.168812017275, 3728.496652951871, 3741.214344987529, 3750.568684601306, 3752.7185461090526, 7149.428045756431, 7418.109826820708, 7419.0, 7437.8140546486775, 7443.4789564729945, 5831.620944638585, 5926.555508336805, 6386.616802991835, 6925.653717314114, 7327.37717294036, 7354.485186036926, 7365.558066516026, 7379.631018449163, 7385.409167266498, 7394.815129621803, 7061.435085193275, 7080.114985626797, 7081.575105493687, 7101.680424380812, 7108.751193708195, 6402.90395644075, 6692.464602831665, 6960.651967401711, 6960.825979350557, 6982.0, 6736.966315168393, 7362.9631851840395, 7375.520591161558, 7405.185429602847, 7445.888311675438, 4670.649701272486, 4674.719516829001, 4685.390899183084, 4686.882827929329, 4693.319468677091, 6893.620850853251, 6998.790036298919, 7001.404880585003, 7007.8248043797275, 7012.929870701431, 5575.275214222287, 6545.803625891231, 6810.0, 6813.0, 6822.3859852613505, 6783.152105986752, 6816.216135144324, 6836.726530938906, 6839.6580170990255, 6842.863142737217, 6618.0, 6631.303713110054, 6632.369924857131, 6635.701393437404, 6636.336366363518, 6038.365971573097, 6293.874122517433, 6791.0, 6807.965960170168, 6821.795346139624, 6326.6520341381665, 6436.195475565554, 6642.933570664425, 6669.366410191024, 6700.497462690415], "unit": "score", "name": "prototype.html", "value": 4945.424799804387}, {"lowerIsBetter": false, "replicates": [682.5120039171994, 687.1204857782039, 705.6401235369966, 712.3731116617375, 763.1833937686674, 14922.77615835762, 15133.621659458518, 15144.469943551978, 15155.0, 15160.54518364448, 13994.79007814881, 15774.369025238977, 16212.675746485063, 16236.025838449672, 16259.0, 742.6064185981438, 751.7143485475511, 918.8529835226365, 928.0533855467419, 938.0338251600862, 915.1397686175007, 934.0985948559638, 934.1919239857508, 934.4113208678523, 935.5415846235363, 983.6901376066517, 988.2538683294139, 992.3748038735587, 992.4938281476462, 993.3741742702088, 764.1899586438366, 774.9031371078615, 775.8331958628866, 970.8301047316727, 973.9318247722662, 712.8289210589473, 726.1467775363926, 726.1685370251085, 727.0076345787961, 727.654364177017, 14044.595540445976, 15490.845091549052, 15516.689666206725, 15556.0, 15558.455454059167, 10403.791924161551, 11863.406829658483, 12590.68523286916, 12855.550055748097, 13109.868901311056, 10020.949895250476, 10046.497675116289, 10074.345167564084, 10350.327228730184, 10357.585696572203, 3404.42124838778, 3440.82795860206, 3461.567304086989, 3461.7749846259912, 3517.2437925846066, 78948.81576776353, 83419.0, 87574.56212718895, 88515.55742221313, 88839.55580222122, 9273.58268877902, 9331.953340233391, 9345.626174953062, 9368.906310936803, 9760.170385517169, 21779.782202178092, 21830.672539911913, 21830.89084554567, 21831.781682183293, 21836.0, 7374.631268436557, 7472.402207823361, 7499.02512673349, 7535.0, 7571.886421703679, 4083.14254006656, 4102.364133559303, 4131.338985762263, 4157.355609880473, 4425.491068527096, 2988.61148050752, 3630.6006339302658, 3640.4357324614725, 3643.4899114124046, 3643.6720695137565, 589.345826132992, 655.4068567946016, 657.552864052449, 658.940695337422, 673.9022841687928, 542.6897804978269, 589.0927970924813, 593.1458699472745, 601.3685630088389, 608.349066498842, 7869.685212591547, 8079.798005049804, 8192.426530142951, 8341.624626891804, 8353.749387518385, 446.698478526993, 579.1717843483774, 602.5661523702927, 604.9697515124226, 630.7477009196358, 3270.0, 3751.381735807131, 3793.791341476245, 3881.5342158940543, 3929.0848107331303, 92444.53777731203, 93141.0685893146, 94203.0, 94239.10489398651, 94668.52665736765, 80134.79797803037, 80139.19860801318, 80731.19268807236, 80994.5950270245, 81419.18580814234, 71360.2863971364, 71795.64102179455, 72274.0, 72349.6382518084, 72823.0, 7601.3918886487845, 7685.577293248702, 7722.0, 7756.457048006585, 7859.921400786147, 46327.07345853131, 50564.74717626535, 51167.744161278955, 51314.0, 53524.0, 65588.0, 69809.3019069823, 69956.30043699498, 69975.0, 70577.29422705913, 9922.801543969224, 9962.55168517404, 11078.612248571262, 11198.776024479303, 11302.852458032947, 11911.523539058688, 11999.165275459016, 12017.0, 12254.693632659255, 12568.057395695176, 11514.712132196762, 11553.075753939496, 11877.346745929057, 12016.75966480683, 12048.337341446304, 11529.0, 11576.0, 11787.115966302734, 11875.13686767107, 12138.968187703791, 11238.494267757807, 11250.66248012561, 11340.94329528347, 11505.712357190803, 11680.532778688757, 9301.348905576815, 9316.44101353921, 9333.533323333942, 9885.802283954425, 10107.292489525662, 8579.598668871899, 8912.0, 9098.226650734761, 9668.613255469983, 9748.463834489172], "unit": "score", "name": "yui.html", "value": 6929.669659748254}], "name": "dromaeo_css", "value": 7421.347390725186}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 109.0, 111.0, 112.0, 112.0, 116.0, 114.0, 157.0, 167.0], "unit": "score", "name": "ai-astar", "value": 122.0}, {"lowerIsBetter": true, "replicates": [156.0, 125.0, 178.0, 190.0, 120.0, 140.0, 139.0, 113.0, 158.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [383.0, 384.0, 388.0, 383.0, 382.0, 379.0, 382.0, 385.0, 383.0, 386.0], "unit": "score", "name": "audio-dft", "value": 383.5}, {"lowerIsBetter": true, "replicates": [78.0, 73.0, 85.0, 78.0, 72.0, 83.0, 83.0, 102.0, 73.0, 44.0], "unit": "score", "name": "audio-fft", "value": 77.1}, {"lowerIsBetter": true, "replicates": [95.0, 99.0, 126.0, 81.0, 78.0, 81.0, 110.0, 76.0, 80.0, 108.0], "unit": "score", "name": "audio-oscillator", "value": 93.4}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 89.0, 86.0, 88.0, 84.0, 89.0, 84.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.0}, {"lowerIsBetter": true, "replicates": [156.0, 158.0, 159.0, 160.0, 157.0, 172.0, 195.0, 159.0, 157.0, 158.0], "unit": "score", "name": "imaging-darkroom", "value": 163.1}, {"lowerIsBetter": true, "replicates": [84.0, 88.0, 86.0, 86.0, 86.0, 96.0, 86.0, 86.0, 87.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 87.2}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 55.0, 53.0, 55.0, 54.0, 53.0, 79.0, 81.0, 81.0], "unit": "score", "name": "json-parse-financial", "value": 62.4}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 73.0, 72.0, 70.0, 65.0, 65.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.7}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 85.0, 97.0, 110.0, 107.0, 81.0, 83.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.7}, {"lowerIsBetter": true, "replicates": [123.0, 145.0, 139.0, 107.0, 124.0, 133.0, 130.0, 136.0, 123.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.9}, {"lowerIsBetter": true, "replicates": [125.0, 124.0, 136.0, 123.0, 138.0, 127.0, 136.0, 137.0, 135.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 131.9}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 63.0, 65.0, 67.0, 67.0, 68.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1703.0000000000005}]} 07:10:05 INFO - Return code: 0 07:10:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:10:05 ERROR - # TBPL SUCCESS # 07:10:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:10:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:10:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:10:05 INFO - 2016-03-14 07:10:05.670 screenresolution[1687:10701] starting screenresolution argv=screenresolution get 07:10:05 INFO - 2016-03-14 07:10:05.672 screenresolution[1687:10701] Display 0: 1600x1200x32@60 07:10:05 INFO - 2016-03-14 07:10:05.678 screenresolution[1688:10704] starting screenresolution argv=screenresolution list 07:10:05 INFO - Available Modes on Display 0 07:10:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:10:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:10:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:10:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:10:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:10:05 INFO - Intel Iris: 07:10:05 INFO - Chipset Model: Intel Iris 07:10:05 INFO - Type: GPU 07:10:05 INFO - Bus: Built-In 07:10:05 INFO - VRAM (Dynamic, Max): 1536 MB 07:10:05 INFO - Vendor: Intel (0x8086) 07:10:05 INFO - Device ID: 0x0a2e 07:10:05 INFO - Revision ID: 0x0009 07:10:05 INFO - Displays: 07:10:05 INFO - Display: 07:10:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:10:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:10:05 INFO - Display Serial Number: 1600x1200 60 07:10:05 INFO - Main Display: Yes 07:10:05 INFO - Mirror: Off 07:10:05 INFO - Online: Yes 07:10:05 INFO - Rotation: Supported 07:10:05 INFO - Return code: 0 07:10:05 INFO - Running post-action listener: _resource_record_post_action 07:10:05 INFO - Running post-run listener: _resource_record_post_run 07:10:06 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 33783296; Write bytes: 706040320; Read time: 384; Write time: 1901 07:10:06 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 397943296; Write bytes: 391652864; Read time: 29957; Write time: 710 07:10:06 INFO - run-tests - Wall time: 1176s; CPU: 52.0%; Read bytes: 31985152; Write bytes: 298230784; Read time: 365; Write time: 1139 07:10:06 INFO - Running post-run listener: _upload_blobber_files 07:10:06 INFO - Blob upload gear active. 07:10:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:10:06 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 07:10:06 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'] 07:10:06 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 07:10:07 INFO - (blobuploader) - INFO - Open directory for files ... 07:10:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:10:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:10:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:08 INFO - (blobuploader) - INFO - Done attempting. 07:10:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:10:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:10:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:09 INFO - (blobuploader) - INFO - Done attempting. 07:10:09 INFO - (blobuploader) - INFO - Iteration through files over. 07:10:09 INFO - Return code: 0 07:10:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:10:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:10:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d553be181e7608f4cf1b20beb5b5cb3d68d8d36c2df91743396c78d85db0829f7bba5263e039d22027199824abc6d236d2899bf1d71378c6dbceb2800b9966a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/716e882e12e60eba7c4a47bdbd4ff064bdad42a5a72d9618d8fe9b11f6bc92a40029f6ee943a185cc590bd95f287f630f6769e54dc2523d64dd9ecb63174254b"} 07:10:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:10:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:10:09 INFO - Contents: 07:10:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d553be181e7608f4cf1b20beb5b5cb3d68d8d36c2df91743396c78d85db0829f7bba5263e039d22027199824abc6d236d2899bf1d71378c6dbceb2800b9966a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/716e882e12e60eba7c4a47bdbd4ff064bdad42a5a72d9618d8fe9b11f6bc92a40029f6ee943a185cc590bd95f287f630f6769e54dc2523d64dd9ecb63174254b"} 07:10:09 INFO - Running post-run listener: copy_logs_to_upload_dir 07:10:09 INFO - Copying logs to upload dir... 07:10:09 INFO - mkdir: /builds/slave/test/build/upload/logs 07:10:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.434093 ========= master_lag: 24.88 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-03-14 07:10:34.287964) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 14 secs) (at 2016-03-14 07:10:34.292134) ========= 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.qRbet5Vm6v/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.YWknkLGiJB/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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/3d553be181e7608f4cf1b20beb5b5cb3d68d8d36c2df91743396c78d85db0829f7bba5263e039d22027199824abc6d236d2899bf1d71378c6dbceb2800b9966a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/716e882e12e60eba7c4a47bdbd4ff064bdad42a5a72d9618d8fe9b11f6bc92a40029f6ee943a185cc590bd95f287f630f6769e54dc2523d64dd9ecb63174254b"} build_url:https://queue.taskcluster.net/v1/task/C7NKY8mNT6SuzmbLhqOsdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011694 build_url: 'https://queue.taskcluster.net/v1/task/C7NKY8mNT6SuzmbLhqOsdw/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/3d553be181e7608f4cf1b20beb5b5cb3d68d8d36c2df91743396c78d85db0829f7bba5263e039d22027199824abc6d236d2899bf1d71378c6dbceb2800b9966a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/716e882e12e60eba7c4a47bdbd4ff064bdad42a5a72d9618d8fe9b11f6bc92a40029f6ee943a185cc590bd95f287f630f6769e54dc2523d64dd9ecb63174254b"}' ========= master_lag: 14.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 14 secs) (at 2016-03-14 07:10:48.417666) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 21 secs) (at 2016-03-14 07:10:48.417979) ========= 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.qRbet5Vm6v/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.YWknkLGiJB/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.005646 ========= master_lag: 21.95 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 21 secs) (at 2016-03-14 07:11:10.374806) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-03-14 07:11:10.375125) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-03-14 07:11:12.452870) ========= ========= Total master_lag: 61.28 =========