builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0128 starttime: 1457658578.5 results: success (0) buildid: 20160310150413 builduid: b63ee2dfdc604e2c83f0d6757727716a revision: 7e4686be6b1f240d4750fa8feae08a5bdf4dd87d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:38.504257) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:38.504762) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:38.505098) ========= 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.XVG6759hTi/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.diGlmWJOzu/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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.005801 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:38.529531) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:38.529886) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:38.546854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:38.547161) ========= 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.XVG6759hTi/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.diGlmWJOzu/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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.005399 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:38.595311) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:38.595643) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:38.596028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:38.596350) ========= 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.XVG6759hTi/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.diGlmWJOzu/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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-10 17:09:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 44.4M=0s 2016-03-10 17:09:38 (44.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155932 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:38.769719) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:38.770088) ========= 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.XVG6759hTi/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.diGlmWJOzu/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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.020779 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:38.882786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 17:09:38.883196) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7e4686be6b1f240d4750fa8feae08a5bdf4dd87d --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 7e4686be6b1f240d4750fa8feae08a5bdf4dd87d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XVG6759hTi/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.diGlmWJOzu/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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-10 17:09:39,094 truncating revision to first 12 chars 2016-03-10 17:09:39,094 Setting DEBUG logging. 2016-03-10 17:09:39,094 attempt 1/10 2016-03-10 17:09:39,094 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7e4686be6b1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-10 17:09:39,761 unpacking tar archive at: fx-team-7e4686be6b1f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.935888 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 17:09:39.972842) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:39.973698) ========= echo 7e4686be6b1f240d4750fa8feae08a5bdf4dd87d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7e4686be6b1f240d4750fa8feae08a5bdf4dd87d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XVG6759hTi/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.diGlmWJOzu/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 7e4686be6b1f240d4750fa8feae08a5bdf4dd87d program finished with exit code 0 elapsedTime=0.005196 script_repo_revision: '7e4686be6b1f240d4750fa8feae08a5bdf4dd87d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:40.026230) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:40.026548) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 17:09:40.042586) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-10 17:09:40.042925) ========= /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.XVG6759hTi/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.diGlmWJOzu/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 17:09:40 INFO - MultiFileLogger online at 20160310 17:09:40 in /builds/slave/test 17:09:40 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 17:09:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:09:40 INFO - {'append_to_log': False, 17:09:40 INFO - 'base_work_dir': '/builds/slave/test', 17:09:40 INFO - 'blob_upload_branch': 'Fx-Team', 17:09:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:09:40 INFO - 'branch': 'Fx-Team', 17:09:40 INFO - 'buildbot_json_path': 'buildprops.json', 17:09:40 INFO - 'config_files': ('talos/mac_config.py',), 17:09:40 INFO - 'default_actions': ('clobber', 17:09:40 INFO - 'read-buildbot-config', 17:09:40 INFO - 'download-and-extract', 17:09:40 INFO - 'populate-webroot', 17:09:40 INFO - 'create-virtualenv', 17:09:40 INFO - 'install', 17:09:40 INFO - 'run-tests'), 17:09:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:09:40 INFO - 'download_minidump_stackwalk': True, 17:09:40 INFO - 'download_symbols': 'ondemand', 17:09:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:09:40 INFO - 'tooltool.py': '/tools/tooltool.py', 17:09:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:09:40 INFO - '/tools/misc-python/virtualenv.py')}, 17:09:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:09:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:09:40 INFO - 'installer_path': 'installer.exe', 17:09:40 INFO - 'log_level': 'info', 17:09:40 INFO - 'log_name': 'talos', 17:09:40 INFO - 'log_to_console': True, 17:09:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:09:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:09:40 INFO - 'opt_config_files': (), 17:09:40 INFO - 'pip_index': False, 17:09:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:09:40 INFO - 'cmd': ('bash', 17:09:40 INFO - '-c', 17:09:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:09:40 INFO - 'enabled': True, 17:09:40 INFO - 'halt_on_failure': False, 17:09:40 INFO - 'name': 'check_screen_resolution'},), 17:09:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:09:40 INFO - 'cmd': ('bash', 17:09:40 INFO - '-c', 17:09:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:09:40 INFO - 'enabled': True, 17:09:40 INFO - 'halt_on_failure': False, 17:09:40 INFO - 'name': 'check_screen_resolution'},), 17:09:40 INFO - 'run_cmd_checks_enabled': True, 17:09:40 INFO - 'sps_profile': False, 17:09:40 INFO - 'sps_profile_interval': 0, 17:09:40 INFO - 'suite': 'dromaeojs', 17:09:40 INFO - 'system_bits': '32', 17:09:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:09:40 INFO - 'title': 't-yosemite-r7-0128', 17:09:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:09:40 INFO - 'use_talos_json': True, 17:09:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:09:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:09:40 INFO - 'work_dir': 'build'} 17:09:40 INFO - ##### 17:09:40 INFO - ##### Running clobber step. 17:09:40 INFO - ##### 17:09:40 INFO - Running pre-action listener: _resource_record_pre_action 17:09:40 INFO - Running main action method: clobber 17:09:40 INFO - rmtree: /builds/slave/test/build 17:09:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:09:41 INFO - Running post-action listener: _resource_record_post_action 17:09:41 INFO - ##### 17:09:41 INFO - ##### Running read-buildbot-config step. 17:09:41 INFO - ##### 17:09:41 INFO - Running pre-action listener: _resource_record_pre_action 17:09:41 INFO - Running main action method: read_buildbot_config 17:09:41 INFO - Using buildbot properties: 17:09:41 INFO - { 17:09:41 INFO - "project": "", 17:09:41 INFO - "product": "firefox", 17:09:41 INFO - "script_repo_revision": "production", 17:09:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 17:09:41 INFO - "repository": "", 17:09:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 17:09:41 INFO - "buildid": "20160310150413", 17:09:41 INFO - "pgo_build": "False", 17:09:41 INFO - "basedir": "/builds/slave/test", 17:09:41 INFO - "buildnumber": 521, 17:09:41 INFO - "slavename": "t-yosemite-r7-0128", 17:09:41 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:09:41 INFO - "platform": "yosemite_r7", 17:09:41 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:09:41 INFO - "branch": "fx-team", 17:09:41 INFO - "repo_path": "integration/fx-team", 17:09:41 INFO - "revision": "7e4686be6b1f240d4750fa8feae08a5bdf4dd87d", 17:09:41 INFO - "stage_platform": "macosx64", 17:09:41 INFO - "builduid": "b63ee2dfdc604e2c83f0d6757727716a", 17:09:41 INFO - "slavebuilddir": "test" 17:09:41 INFO - } 17:09:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 17:09:41 INFO - Running post-action listener: _resource_record_post_action 17:09:41 INFO - ##### 17:09:41 INFO - ##### Running download-and-extract step. 17:09:41 INFO - ##### 17:09:41 INFO - Running pre-action listener: _resource_record_pre_action 17:09:41 INFO - Running main action method: download_and_extract 17:09:41 INFO - mkdir: /builds/slave/test/build/tests 17:09:41 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')]} 17:09:41 INFO - https://queue.taskcluster.net/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:09:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:09:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:09:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/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 17:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/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 17:09:43 INFO - Downloaded 1199 bytes. 17:09:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:09:43 INFO - Using the following test package requirements: 17:09:43 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:09:43 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:43 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 17:09:43 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:43 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 17:09:43 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:43 INFO - u'jsshell-mac.zip'], 17:09:43 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:43 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 17:09:43 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:09:43 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:43 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 17:09:43 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:43 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 17:09:43 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:43 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 17:09:43 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:43 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 17:09:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:09: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')]} 17:09:43 INFO - https://queue.taskcluster.net/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:09:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:09:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:09:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/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 17:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/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 17:09:44 INFO - Downloaded 17867693 bytes. 17:09:44 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'] 17:09:44 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 17:09:47 INFO - Return code: 0 17:09:47 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 17:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:47 INFO - https://queue.taskcluster.net/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:09:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:09:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:09:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/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 17:09:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/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 17:09:48 INFO - Downloaded 17867693 bytes. 17:09:48 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'] 17:09:48 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 17:09:52 INFO - Return code: 0 17:09:52 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')]} 17:09:52 INFO - https://queue.taskcluster.net/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:09:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:09:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:09:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/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 17:09:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/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 17:09:53 INFO - Downloaded 10845161 bytes. 17:09:53 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'] 17:09:53 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 17:09:53 INFO - Return code: 0 17:09:53 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')]} 17:09:53 INFO - https://queue.taskcluster.net/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:09:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:09:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:09:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 17:09:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RlC6xTSwS4itryDWbBHDCQ/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 17:09:56 INFO - Downloaded 110988520 bytes. 17:09:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:09:56 INFO - mkdir: /builds/slave/test/properties 17:09:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:09:56 INFO - Writing to file /builds/slave/test/properties/build_url 17:09:56 INFO - Contents: 17:09:56 INFO - build_url:https://queue.taskcluster.net/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:09:57 INFO - Running post-action listener: _resource_record_post_action 17:09:57 INFO - Running post-action listener: set_extra_try_arguments 17:09:57 INFO - ##### 17:09:57 INFO - ##### Running populate-webroot step. 17:09:57 INFO - ##### 17:09:57 INFO - Running pre-action listener: _resource_record_pre_action 17:09:57 INFO - Running main action method: populate_webroot 17:09:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:09:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:09:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:09:57 INFO - '--tppagecycles', 17:09:57 INFO - '7'], 17:09:57 INFO - 'tests': ['tsvgm']}}, 17:09:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:09:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:09:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:09:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:09:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:09:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:09:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'talos_options': ['--e10s'], 17:09:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'tests': ['damp', 'tps']}, 17:09:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'talos_options': ['--e10s'], 17:09:57 INFO - 'tests': ['damp', 'tps']}, 17:09:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:09:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:09:57 INFO - 'other': {'tests': ['a11yr', 17:09:57 INFO - 'ts_paint', 17:09:57 INFO - 'tpaint', 17:09:57 INFO - 'sessionrestore', 17:09:57 INFO - 'sessionrestore_no_auto_restore', 17:09:57 INFO - 'tabpaint']}, 17:09:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:09:57 INFO - 'tests': ['a11yr', 17:09:57 INFO - 'ts_paint', 17:09:57 INFO - 'tpaint', 17:09:57 INFO - 'sessionrestore', 17:09:57 INFO - 'sessionrestore_no_auto_restore', 17:09:57 INFO - 'tabpaint']}, 17:09:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:09:57 INFO - 'tests': ['a11yr', 17:09:57 INFO - 'ts_paint', 17:09:57 INFO - 'tpaint', 17:09:57 INFO - 'sessionrestore', 17:09:57 INFO - 'sessionrestore_no_auto_restore', 17:09:57 INFO - 'tabpaint']}, 17:09:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:09:57 INFO - 'tests': ['a11yr', 17:09:57 INFO - 'ts_paint', 17:09:57 INFO - 'tpaint', 17:09:57 INFO - 'sessionrestore', 17:09:57 INFO - 'sessionrestore_no_auto_restore', 17:09:57 INFO - 'tabpaint']}, 17:09:57 INFO - 'other_l64': {'tests': ['a11yr', 17:09:57 INFO - 'ts_paint', 17:09:57 INFO - 'tpaint', 17:09:57 INFO - 'sessionrestore', 17:09:57 INFO - 'sessionrestore_no_auto_restore', 17:09:57 INFO - 'tabpaint']}, 17:09:57 INFO - 'other_nol64': {'tests': ['a11yr', 17:09:57 INFO - 'ts_paint', 17:09:57 INFO - 'tpaint', 17:09:57 INFO - 'sessionrestore', 17:09:57 INFO - 'sessionrestore_no_auto_restore', 17:09:57 INFO - 'tabpaint']}, 17:09:57 INFO - 'svgr': {'tests': ['tsvgx', 17:09:57 INFO - 'tsvgr_opacity', 17:09:57 INFO - 'tart', 17:09:57 INFO - 'tscrollx', 17:09:57 INFO - 'cart']}, 17:09:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:09:57 INFO - 'tests': ['tsvgx', 17:09:57 INFO - 'tsvgr_opacity', 17:09:57 INFO - 'tart', 17:09:57 INFO - 'tscrollx', 17:09:57 INFO - 'cart']}, 17:09:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'tests': ['tp5o']}, 17:09:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'talos_options': ['--e10s'], 17:09:57 INFO - 'tests': ['tp5o']}, 17:09:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'talos_options': ['--xperf_path', 17:09:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:57 INFO - 'tests': ['tp5n']}, 17:09:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:57 INFO - 'talos_options': ['--e10s', 17:09:57 INFO - '--xperf_path', 17:09:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:57 INFO - 'tests': ['tp5n']}}, 17:09:57 INFO - 'talos.zip': {'path': '', 17:09:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:09:57 INFO - Running post-action listener: _resource_record_post_action 17:09:57 INFO - ##### 17:09:57 INFO - ##### Running create-virtualenv step. 17:09:57 INFO - ##### 17:09:57 INFO - Running pre-action listener: _resource_record_pre_action 17:09:57 INFO - Running main action method: create_virtualenv 17:09:57 INFO - Creating virtualenv /builds/slave/test/build/venv 17:09:57 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 17:09:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:09:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:09:57 INFO - Using real prefix '/tools/python27' 17:09:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:09:58 INFO - Installing distribute.............................................................................................................................................................................................done. 17:10:01 INFO - Installing pip.................done. 17:10:01 INFO - Return code: 0 17:10:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:01 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 0x1017baa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f970b59fa20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10165ed30>, '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 0x101482db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101655b20>, '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.XVG6759hTi/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.diGlmWJOzu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 17:10:01 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 17:10:01 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 17:10:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVG6759hTi/Render', 17:10:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:01 INFO - 'HOME': '/Users/cltbld', 17:10:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:01 INFO - 'LOGNAME': 'cltbld', 17:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:01 INFO - 'MOZ_NO_REMOTE': '1', 17:10:01 INFO - 'NO_EM_RESTART': '1', 17:10:01 INFO - 'PAGER': '/bin/cat', 17:10:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:01 INFO - 'PWD': '/builds/slave/test', 17:10:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:01 INFO - 'SHELL': '/bin/bash', 17:10:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diGlmWJOzu/Listeners', 17:10:01 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 17:10:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:01 INFO - 'USER': 'cltbld', 17:10:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:01 INFO - 'XPC_FLAGS': '0x0', 17:10:01 INFO - 'XPC_SERVICE_NAME': '0', 17:10:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:01 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 17:10:01 INFO - Cleaning up... 17:10:01 INFO - Return code: 0 17:10:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:01 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 0x1017baa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f970b59fa20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10165ed30>, '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 0x101482db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101655b20>, '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.XVG6759hTi/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.diGlmWJOzu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 17:10:01 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 17:10:01 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 17:10:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVG6759hTi/Render', 17:10:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:01 INFO - 'HOME': '/Users/cltbld', 17:10:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:01 INFO - 'LOGNAME': 'cltbld', 17:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:01 INFO - 'MOZ_NO_REMOTE': '1', 17:10:01 INFO - 'NO_EM_RESTART': '1', 17:10:01 INFO - 'PAGER': '/bin/cat', 17:10:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:01 INFO - 'PWD': '/builds/slave/test', 17:10:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:01 INFO - 'SHELL': '/bin/bash', 17:10:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diGlmWJOzu/Listeners', 17:10:01 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 17:10:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:01 INFO - 'USER': 'cltbld', 17:10:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:01 INFO - 'XPC_FLAGS': '0x0', 17:10:01 INFO - 'XPC_SERVICE_NAME': '0', 17:10:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:01 INFO - Downloading/unpacking psutil>=0.7.1 17:10:01 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 17:10:01 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 17:10:01 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 17:10:01 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 17:10:01 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 17:10:01 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 17:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:10:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:04 INFO - Installing collected packages: psutil 17:10:04 INFO - Running setup.py install for psutil 17:10:04 INFO - building 'psutil._psutil_osx' extension 17:10:04 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 17:10:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:10:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:10:05 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 17:10:05 INFO - building 'psutil._psutil_posix' extension 17:10:05 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 17:10:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:10:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:10:05 INFO - ^ 17:10:05 INFO - 1 warning generated. 17:10:05 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 17:10:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:05 INFO - Successfully installed psutil 17:10:05 INFO - Cleaning up... 17:10:05 INFO - Return code: 0 17:10:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:10: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')]} 17:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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')]} 17:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:05 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 0x1017baa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f970b59fa20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10165ed30>, '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 0x101482db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101655b20>, '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.XVG6759hTi/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.diGlmWJOzu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 17:10:05 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 17:10:05 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 17:10:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVG6759hTi/Render', 17:10:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:05 INFO - 'HOME': '/Users/cltbld', 17:10:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:05 INFO - 'LOGNAME': 'cltbld', 17:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:05 INFO - 'MOZ_NO_REMOTE': '1', 17:10:05 INFO - 'NO_EM_RESTART': '1', 17:10:05 INFO - 'PAGER': '/bin/cat', 17:10:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:05 INFO - 'PWD': '/builds/slave/test', 17:10:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:05 INFO - 'SHELL': '/bin/bash', 17:10:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diGlmWJOzu/Listeners', 17:10:05 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 17:10:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:05 INFO - 'USER': 'cltbld', 17:10:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:05 INFO - 'XPC_FLAGS': '0x0', 17:10:05 INFO - 'XPC_SERVICE_NAME': '0', 17:10:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:10:05 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 17:10:05 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 17:10:05 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 17:10:05 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 17:10:05 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 17:10:05 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 17:10:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:10:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:10:08 INFO - Installing collected packages: mozsystemmonitor 17:10:08 INFO - Running setup.py install for mozsystemmonitor 17:10:08 INFO - Successfully installed mozsystemmonitor 17:10:08 INFO - Cleaning up... 17:10:08 INFO - Return code: 0 17:10:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:10:08 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')]} 17:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:08 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')]} 17:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:08 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 0x1017baa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f970b59fa20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10165ed30>, '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 0x101482db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101655b20>, '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.XVG6759hTi/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.diGlmWJOzu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 17:10:08 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 17:10:08 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 17:10:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVG6759hTi/Render', 17:10:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:08 INFO - 'HOME': '/Users/cltbld', 17:10:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:08 INFO - 'LOGNAME': 'cltbld', 17:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:08 INFO - 'MOZ_NO_REMOTE': '1', 17:10:08 INFO - 'NO_EM_RESTART': '1', 17:10:08 INFO - 'PAGER': '/bin/cat', 17:10:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:08 INFO - 'PWD': '/builds/slave/test', 17:10:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:08 INFO - 'SHELL': '/bin/bash', 17:10:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diGlmWJOzu/Listeners', 17:10:08 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 17:10:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:08 INFO - 'USER': 'cltbld', 17:10:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:08 INFO - 'XPC_FLAGS': '0x0', 17:10:08 INFO - 'XPC_SERVICE_NAME': '0', 17:10:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:08 INFO - Downloading/unpacking blobuploader==1.2.4 17:10:08 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 17:10:08 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 17:10:08 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 17:10:08 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 17:10:08 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 17:10:08 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 17:10:11 INFO - Downloading blobuploader-1.2.4.tar.gz 17:10:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:10:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:10:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:12 INFO - Downloading docopt-0.6.1.tar.gz 17:10:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:10:12 INFO - Installing collected packages: blobuploader, requests, docopt 17:10:12 INFO - Running setup.py install for blobuploader 17:10:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:10:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:10:12 INFO - Running setup.py install for requests 17:10:12 INFO - Running setup.py install for docopt 17:10:13 INFO - Successfully installed blobuploader requests docopt 17:10:13 INFO - Cleaning up... 17:10:13 INFO - Return code: 0 17:10:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:13 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')]} 17:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:13 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')]} 17:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:13 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 0x1017baa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f970b59fa20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10165ed30>, '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 0x101482db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101655b20>, '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.XVG6759hTi/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.diGlmWJOzu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 17:10:13 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 17:10:13 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 17:10:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVG6759hTi/Render', 17:10:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:13 INFO - 'HOME': '/Users/cltbld', 17:10:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:13 INFO - 'LOGNAME': 'cltbld', 17:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:13 INFO - 'MOZ_NO_REMOTE': '1', 17:10:13 INFO - 'NO_EM_RESTART': '1', 17:10:13 INFO - 'PAGER': '/bin/cat', 17:10:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:13 INFO - 'PWD': '/builds/slave/test', 17:10:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:13 INFO - 'SHELL': '/bin/bash', 17:10:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diGlmWJOzu/Listeners', 17:10:13 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 17:10:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:13 INFO - 'USER': 'cltbld', 17:10:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:13 INFO - 'XPC_FLAGS': '0x0', 17:10:13 INFO - 'XPC_SERVICE_NAME': '0', 17:10:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:13 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-vEi_Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:13 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-vnKkfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:13 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-tXmcb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:13 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-uD7L0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:13 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-n_87pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:13 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-HPqRiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:13 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-BPrEzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:14 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-SoyOLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:14 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-Sb7I1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:14 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-qlN57L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:14 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-D9jVX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:14 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-qEWY2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:14 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-FiHIPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:14 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-ZMIFPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:14 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-uj9cI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:14 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-0qpKg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:15 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-iW_O9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:10:15 INFO - Running setup.py install for manifestparser 17:10:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:10:15 INFO - Running setup.py install for mozcrash 17:10:15 INFO - Running setup.py install for mozdebug 17:10:15 INFO - Running setup.py install for mozdevice 17:10:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:10:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:10:15 INFO - Running setup.py install for mozfile 17:10:15 INFO - Running setup.py install for mozhttpd 17:10:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:10:16 INFO - Running setup.py install for mozinfo 17:10:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:10:16 INFO - Running setup.py install for mozInstall 17:10:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:10:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:10:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:10:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:10:16 INFO - Running setup.py install for mozleak 17:10:16 INFO - Running setup.py install for mozlog 17:10:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:10:16 INFO - Running setup.py install for moznetwork 17:10:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:10:16 INFO - Running setup.py install for mozprocess 17:10:16 INFO - Running setup.py install for mozprofile 17:10:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:10:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:10:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:10:17 INFO - Running setup.py install for mozrunner 17:10:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:10:17 INFO - Running setup.py install for mozscreenshot 17:10:17 INFO - Running setup.py install for moztest 17:10:17 INFO - Running setup.py install for mozversion 17:10:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:10:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:10:17 INFO - Cleaning up... 17:10:17 INFO - Return code: 0 17:10:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10: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')]} 17:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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')]} 17:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:17 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 0x1017baa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f970b59fa20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10165ed30>, '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 0x101482db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101655b20>, '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.XVG6759hTi/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.diGlmWJOzu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 17:10:17 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 17:10:17 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 17:10:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVG6759hTi/Render', 17:10:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:17 INFO - 'HOME': '/Users/cltbld', 17:10:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:17 INFO - 'LOGNAME': 'cltbld', 17:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:17 INFO - 'MOZ_NO_REMOTE': '1', 17:10:17 INFO - 'NO_EM_RESTART': '1', 17:10:17 INFO - 'PAGER': '/bin/cat', 17:10:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:17 INFO - 'PWD': '/builds/slave/test', 17:10:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:17 INFO - 'SHELL': '/bin/bash', 17:10:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diGlmWJOzu/Listeners', 17:10:17 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 17:10:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:17 INFO - 'USER': 'cltbld', 17:10:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:17 INFO - 'XPC_FLAGS': '0x0', 17:10:17 INFO - 'XPC_SERVICE_NAME': '0', 17:10:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:17 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-9Ol_Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:18 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)) 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:18 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-IZqPSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:18 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)) 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:18 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-WrXgiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:18 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)) 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:18 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-yCerHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:18 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)) 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:18 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-E7wB33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:18 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)) 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:18 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-tLyDuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:18 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)) 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:18 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-B26gZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:18 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)) 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:18 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-Z_WBXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:18 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)) 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:18 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-bxzUre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:18 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)) 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:18 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-6M_qRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:19 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)) 17:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:19 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-VSnfWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:19 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)) 17:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:19 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-Y5jWRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:19 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)) 17:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:19 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-regNIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:19 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)) 17:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:19 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-OmbLof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:19 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)) 17:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:19 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-OCC0cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:19 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)) 17:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:19 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-UpWcg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:19 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)) 17:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:19 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-Cadtpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:19 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)) 17:10:19 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)) 17:10:19 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)) 17:10:19 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)) 17:10:19 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)) 17:10:19 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)) 17:10:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:10:19 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 17:10:19 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 17:10:19 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 17:10:19 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 17:10:19 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 17:10:19 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 17:10:22 INFO - Downloading blessings-1.6.tar.gz 17:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:10:22 INFO - Installing collected packages: blessings 17:10:22 INFO - Running setup.py install for blessings 17:10:22 INFO - Successfully installed blessings 17:10:22 INFO - Cleaning up... 17:10:22 INFO - Return code: 0 17:10:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:10:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:22 INFO - Reading from file tmpfile_stdout 17:10:22 INFO - Current package versions: 17:10:22 INFO - blessings == 1.6 17:10:22 INFO - blobuploader == 1.2.4 17:10:22 INFO - docopt == 0.6.1 17:10:22 INFO - manifestparser == 1.1 17:10:22 INFO - mozInstall == 1.12 17:10:22 INFO - mozcrash == 0.17 17:10:22 INFO - mozdebug == 0.1 17:10:22 INFO - mozdevice == 0.48 17:10:22 INFO - mozfile == 1.2 17:10:22 INFO - mozhttpd == 0.7 17:10:22 INFO - mozinfo == 0.9 17:10:22 INFO - mozleak == 0.1 17:10:22 INFO - mozlog == 3.1 17:10:22 INFO - moznetwork == 0.27 17:10:22 INFO - mozprocess == 0.22 17:10:22 INFO - mozprofile == 0.28 17:10:22 INFO - mozrunner == 6.11 17:10:22 INFO - mozscreenshot == 0.1 17:10:22 INFO - mozsystemmonitor == 0.0 17:10:22 INFO - moztest == 0.7 17:10:22 INFO - mozversion == 1.4 17:10:22 INFO - psutil == 3.1.1 17:10:22 INFO - requests == 1.2.3 17:10:22 INFO - wsgiref == 0.1.2 17:10:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:22 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 0x1017baa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f970b59fa20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10165ed30>, '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 0x101482db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101655b20>, '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.XVG6759hTi/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.diGlmWJOzu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 17:10:22 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 17:10:22 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 17:10:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVG6759hTi/Render', 17:10:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:22 INFO - 'HOME': '/Users/cltbld', 17:10:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:22 INFO - 'LOGNAME': 'cltbld', 17:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:22 INFO - 'MOZ_NO_REMOTE': '1', 17:10:22 INFO - 'NO_EM_RESTART': '1', 17:10:22 INFO - 'PAGER': '/bin/cat', 17:10:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:22 INFO - 'PWD': '/builds/slave/test', 17:10:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:22 INFO - 'SHELL': '/bin/bash', 17:10:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diGlmWJOzu/Listeners', 17:10:22 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 17:10:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:22 INFO - 'USER': 'cltbld', 17:10:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:22 INFO - 'XPC_FLAGS': '0x0', 17:10:22 INFO - 'XPC_SERVICE_NAME': '0', 17:10:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 INFO - Cleaning up... 17:10:23 INFO - Return code: 0 17:10:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017baa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f970b59fa20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10165ed30>, '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 0x101482db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101655b20>, '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.XVG6759hTi/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.diGlmWJOzu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 17:10:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:10:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVG6759hTi/Render', 17:10:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:23 INFO - 'HOME': '/Users/cltbld', 17:10:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:23 INFO - 'LOGNAME': 'cltbld', 17:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:23 INFO - 'MOZ_NO_REMOTE': '1', 17:10:23 INFO - 'NO_EM_RESTART': '1', 17:10:23 INFO - 'PAGER': '/bin/cat', 17:10:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:23 INFO - 'PWD': '/builds/slave/test', 17:10:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:23 INFO - 'SHELL': '/bin/bash', 17:10:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diGlmWJOzu/Listeners', 17:10:23 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 17:10:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:23 INFO - 'USER': 'cltbld', 17:10:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:23 INFO - 'XPC_FLAGS': '0x0', 17:10:23 INFO - 'XPC_SERVICE_NAME': '0', 17:10:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:23 INFO - Downloading/unpacking jsonschema 17:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:10:25 INFO - Downloading/unpacking functools32 (from jsonschema) 17:10:25 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 17:10:25 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 17:10:25 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 17:10:25 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 17:10:25 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 17:10:25 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 17:10:26 INFO - Downloading functools32-3.2.3-2.tar.gz 17:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:10:26 INFO - warning: no files found matching '*.txt' 17:10:26 INFO - no previously-included directories found matching 'build' 17:10:26 INFO - no previously-included directories found matching 'dist' 17:10:26 INFO - no previously-included directories found matching '.git*' 17:10:26 INFO - Installing collected packages: jsonschema, functools32 17:10:26 INFO - Running setup.py install for functools32 17:10:26 INFO - warning: no files found matching '*.txt' 17:10:26 INFO - no previously-included directories found matching 'build' 17:10:26 INFO - no previously-included directories found matching 'dist' 17:10:26 INFO - no previously-included directories found matching '.git*' 17:10:26 INFO - Successfully installed jsonschema functools32 17:10:26 INFO - Cleaning up... 17:10:26 INFO - Return code: 0 17:10:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:10: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')]} 17:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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')]} 17:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017baa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f970b59fa20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10165ed30>, '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 0x101482db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101655b20>, '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.XVG6759hTi/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.diGlmWJOzu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 17:10: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', 'flake8'] in /builds/slave/test/build 17:10: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 flake8 17:10:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVG6759hTi/Render', 17:10:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:26 INFO - 'HOME': '/Users/cltbld', 17:10:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:26 INFO - 'LOGNAME': 'cltbld', 17:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:26 INFO - 'MOZ_NO_REMOTE': '1', 17:10:26 INFO - 'NO_EM_RESTART': '1', 17:10:26 INFO - 'PAGER': '/bin/cat', 17:10:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:26 INFO - 'PWD': '/builds/slave/test', 17:10:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:26 INFO - 'SHELL': '/bin/bash', 17:10:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diGlmWJOzu/Listeners', 17:10:26 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 17:10:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:26 INFO - 'USER': 'cltbld', 17:10:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:26 INFO - 'XPC_FLAGS': '0x0', 17:10:26 INFO - 'XPC_SERVICE_NAME': '0', 17:10:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:26 INFO - Downloading/unpacking flake8 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:10:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:10:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:10:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:30 INFO - no previously-included directories found matching 'docs/_build' 17:10:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:10:30 INFO - Running setup.py install for pep8 17:10:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:30 INFO - no previously-included directories found matching 'docs/_build' 17:10:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:10:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:10:30 INFO - Cleaning up... 17:10:30 INFO - Return code: 0 17:10:30 INFO - Running post-action listener: _resource_record_post_action 17:10:30 INFO - Running post-action listener: _start_resource_monitoring 17:10:30 INFO - Starting resource monitoring. 17:10:30 INFO - ##### 17:10:30 INFO - ##### Running install step. 17:10:30 INFO - ##### 17:10:30 INFO - Running pre-action listener: _resource_record_pre_action 17:10:30 INFO - Running main action method: install 17:10:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:31 INFO - Reading from file tmpfile_stdout 17:10:31 INFO - Detecting whether we're running mozinstall >=1.0... 17:10:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:10:31 INFO - Reading from file tmpfile_stdout 17:10:31 INFO - Output received: 17:10:31 INFO - Usage: mozinstall [options] installer 17:10:31 INFO - Options: 17:10:31 INFO - -h, --help show this help message and exit 17:10:31 INFO - -d DEST, --destination=DEST 17:10:31 INFO - Directory to install application into. [default: 17:10:31 INFO - "/builds/slave/test"] 17:10:31 INFO - --app=APP Application being installed. [default: firefox] 17:10:31 INFO - mkdir: /builds/slave/test/build/application 17:10:31 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'] 17:10:31 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 17:11:04 INFO - Reading from file tmpfile_stdout 17:11:04 INFO - Output received: 17:11:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:11:04 INFO - Running post-action listener: _resource_record_post_action 17:11:04 INFO - ##### 17:11:04 INFO - ##### Running run-tests step. 17:11:04 INFO - ##### 17:11:04 INFO - Running pre-action listener: _resource_record_pre_action 17:11:04 INFO - Running main action method: run_tests 17:11:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:11:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:11:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:11:04 INFO - 2016-03-10 17:11:04.435 screenresolution[1911:13551] starting screenresolution argv=screenresolution get 17:11:04 INFO - 2016-03-10 17:11:04.438 screenresolution[1911:13551] Display 0: 1600x1200x32@60 17:11:04 INFO - 2016-03-10 17:11:04.443 screenresolution[1912:13554] starting screenresolution argv=screenresolution list 17:11:04 INFO - Available Modes on Display 0 17:11:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:11:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:11:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:11:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:11:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:11:04 INFO - Intel Iris: 17:11:04 INFO - Chipset Model: Intel Iris 17:11:04 INFO - Type: GPU 17:11:04 INFO - Bus: Built-In 17:11:04 INFO - VRAM (Dynamic, Max): 1536 MB 17:11:04 INFO - Vendor: Intel (0x8086) 17:11:04 INFO - Device ID: 0x0a2e 17:11:04 INFO - Revision ID: 0x0009 17:11:04 INFO - Displays: 17:11:04 INFO - Display: 17:11:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:11:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:11:04 INFO - Display Serial Number: 1600x1200 60 17:11:04 INFO - Main Display: Yes 17:11:04 INFO - Mirror: Off 17:11:04 INFO - Online: Yes 17:11:04 INFO - Rotation: Supported 17:11:04 INFO - Return code: 0 17:11:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:11:04 INFO - Python 2.7.3 17:11:04 INFO - Return code: 0 17:11:04 INFO - grabbing minidump binary from tooltool 17:11: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')]} 17:11:04 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 0x10165ed30>, '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 0x101482db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101655b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:11:04 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 17:11:04 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 17:11:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:11:04 INFO - Return code: 0 17:11:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:11:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:11:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:11:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:11:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:11:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:11:05 INFO - Return code: 0 17:11:05 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/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0128', '--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 17:11:05 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/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0128 --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 17:11:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVG6759hTi/Render', 17:11:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:05 INFO - 'HOME': '/Users/cltbld', 17:11:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:05 INFO - 'LOGNAME': 'cltbld', 17:11:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:11:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:05 INFO - 'MOZ_NO_REMOTE': '1', 17:11:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:11:05 INFO - 'NO_EM_RESTART': '1', 17:11:05 INFO - 'PAGER': '/bin/cat', 17:11:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:05 INFO - 'PWD': '/builds/slave/test', 17:11:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:11:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:05 INFO - 'SHELL': '/bin/bash', 17:11:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diGlmWJOzu/Listeners', 17:11:05 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 17:11:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:05 INFO - 'USER': 'cltbld', 17:11:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:05 INFO - 'XPC_FLAGS': '0x0', 17:11:05 INFO - 'XPC_SERVICE_NAME': '0', 17:11:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:05 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/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0128', '--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 17:11:06 INFO - mozversion application_buildid: 20160310150413 17:11:06 INFO - mozversion application_changeset: 7e4686be6b1f240d4750fa8feae08a5bdf4dd87d 17:11:06 INFO - mozversion application_display_name: Nightly 17:11:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:11:06 INFO - mozversion application_name: Firefox 17:11:06 INFO - mozversion application_remotingname: firefox 17:11:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:11:06 INFO - mozversion application_vendor: Mozilla 17:11:06 INFO - mozversion application_version: 48.0a1 17:11:06 INFO - mozversion platform_buildid: 20160310150413 17:11:06 INFO - mozversion platform_changeset: 7e4686be6b1f240d4750fa8feae08a5bdf4dd87d 17:11:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:11:06 INFO - mozversion platform_version: 48.0a1 17:11:06 INFO - using testdate: 1457658666 17:11:06 INFO - actual date: 1457658666 17:11:06 INFO - starting webserver on 'localhost:50863' 17:11:06 INFO - SUITE-START | Running 2 tests 17:11:06 INFO - TEST-START | dromaeo_css 17:11:06 INFO - operating with platform_type : mac_ 17:11:06 INFO - Initialising browser for dromaeo_css test... 17:11:06 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/tmpiPnwo1/profile http://localhost:50863/getInfo.html) 17:11:08 INFO - PROCESS | 1930 | __metrics Screen width/height:1600/1200 17:11:08 INFO - PROCESS | 1930 | colorDepth:24 17:11:08 INFO - PROCESS | 1930 | Browser inner width/height: 1024/689 17:11:08 INFO - PROCESS | 1930 | __metrics 17:11:08 INFO - PROCESS | 1930 | 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" 17:11:08 ERROR - PROCESS | 1930 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:11:09 INFO - TEST-INFO | 1930: exit 0 17:11:09 INFO - Browser initialized. 17:11:09 INFO - Running cycle 1/1 for dromaeo_css test... 17:11:09 INFO - TEST-INFO | started process 1933 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/tmpiPnwo1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:20 INFO - PROCESS | 1933 | RSS: Main: 243376128 17:11:20 INFO - PROCESS | 1933 | 17:12:12 INFO - PROCESS | 1933 | 1457658732046 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] 17:14:22 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:50863/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50863/tests/dromaeo/cssquery-ext.html) 17:14:23 INFO - PROCESS | 1933 | RSS: Main: 363728896 17:14:23 INFO - PROCESS | 1933 | 17:17:26 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:50863/tests/dromaeo/cssquery-ext.html (next: http://localhost:50863/tests/dromaeo/cssquery-jquery.html) 17:17:27 INFO - PROCESS | 1933 | RSS: Main: 373186560 17:17:27 INFO - PROCESS | 1933 | 17:20:29 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:50863/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50863/tests/dromaeo/cssquery-mootools.html) 17:20:29 INFO - PROCESS | 1933 | RSS: Main: 373395456 17:20:29 INFO - PROCESS | 1933 | 17:23:31 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:50863/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50863/tests/dromaeo/cssquery-prototype.html) 17:23:32 INFO - PROCESS | 1933 | RSS: Main: 345079808 17:23:32 INFO - PROCESS | 1933 | 17:26:35 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:50863/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50863/tests/dromaeo/cssquery-yui.html) 17:26:36 INFO - PROCESS | 1933 | RSS: Main: 344084480 17:26:36 INFO - PROCESS | 1933 | 17:29:38 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:50863/tests/dromaeo/cssquery-yui.html (next: http://localhost:50863/tests/dromaeo/cssquery-dojo.html) 17:29:39 INFO - PROCESS | 1933 | RSS: Main: 381841408 17:29:39 INFO - PROCESS | 1933 | 17:29:39 INFO - PROCESS | 1933 | __start_tp_report 17:29:39 INFO - PROCESS | 1933 | _x_x_mozilla_page_load 17:29:39 INFO - PROCESS | 1933 | _x_x_mozilla_page_load_details 17:29:39 INFO - PROCESS | 1933 | |i|pagename|runs| 17:29:39 INFO - PROCESS | 1933 | |0;dojo.html;3436.2096717754916;3470.357983773002;3510.385682505561;3520.049586611615;3560;5598.1322894951345;5630.943690563093;5643.492085712285;5664.065429204182;5688.9999999999945;5656.066748986423;5660.518855897243;5694.715264236782;5785.016547186978;5805.303363596375;5062.392512898439;5105.208692652635;5106.208537676647;5114.488551144875;5165.845024649267;5234.895302093956;5274.789008439677;5302.92045619316;5309.920351194735;5353.03645343838;5065.316182315377;5078.873028174288;5166.483351664822;5170.431252562215;5218.086834803932;5147.073526765181;5160.14857548504;5180.119379705421;5181.870453238662;5184.403793563751;5077.238414237857;5104.770285337168;5138.049460849717;5150.61370397218;5155.252488389163;5489.890202195974;5573.108302671553;5595.916061259044;5690.487856092972;5690.800821971253;6207.503399728011;6221.751129954796;6227.688615569204;6246.625202487865;6252.687365631746;6227.688615569204;6275.7489700411925;6285.96857015712;6303.086052522359;6303.716332765037;5604.971975140098;5642.633228840071;5704.714764261853;5713.771449142029;5717.685527295997;6212.502999760009;6290.874182516324;6294.622322660563;6301.684915754286;6308.621482710961;6091.51267898567;6152.046432802923;6166.969165154235;6169.537284703665;6186.10301506288;6109.708332504907;6218.782342617987;6272.153259310026;6286.151369565142;6289.245290565162;6136.20229370179;6196.845078873064;6203;6220.906686399708;6230.252369715572;6212.223472065992;6223.719932603044;6245.687715614201;6251.687415629201;6263.812085637438;4791.496892826203;4809.398825146856;4862.902741945141;4894.559489645878;4904.926426103611;4317.827286908551;4347.478302603708;4364.454443194601;4408.294672852328;4418.315161150027;4836.854894353175;5663.801766938137;5670.064439367458;5701.885962280814;5733.168690539848;6105.908411373833;6208.286047104551;6265.091561723616;6290.496760259169;6306.369363063749;5656.8020119295625;5703.458171473703;5709.115087161496;5715.599908006399;5763.077907534775;5330.840074797762;5339.5728341732565;5345.33183352081;5345.946540534623;5350.197470379474;6191.4118158774845;6197.566170368031;6292.339304373158;6296;6328.367163283727;6241.375862413904;6279.717412716347;6281.96859015702;6286.025666021774;6292.993121100602;6236.906446403217;6283.434490895841;6295.716692748746;6295.929691952288;6302.527310451643;6022.939770602413;6117.418845209698;6140.109684095692;6179.907301390573;6189.659568723763;6091.664958427152;6190.783322583688;6221.129041934223;6253.468455181361;6261.405166509175;6057.697115144313;6079.848003799941;6080.513558915188;6085.711159955039;6116.061877111602;5928.881422371443;6030.39696030411;6052.03167493199;6108.816735497942;6120.969395152996;5924.9927512323875;5941.643501389931;5952.791652292149;5954.583179177416;6004.069369247599;6059.3637668045985;6059.545534084873;6116.480099191618;6123.7244324006415;6142.1266513713745;5757.050086735641;5848.853778655568;5868.002439585366;5936.28764548257;5941.732622032106 17:29:39 INFO - PROCESS | 1933 | |1;ext.html;445.2719803121895;575.2981362737459;576.9758678345938;631.2172905597058;649.0718272869796;26726.866365668167;39787.40318895215;40211.597884021154;40236;40354.78935631936;42711;43336;43391;43435.78282108585;43667.78166109173;9579.233661307078;9846.163076138537;9848.113669769718;9854.507274636275;9856.310058295921;8629.439086459392;9713.660021899235;9743.658971935984;9869.753256168617;9886.357386769872;9898.653547125852;9980.051895069957;9991.000899910023;10002.299839011272;10013.299069065168;9883.50582470877;9957.751056223653;9962.103410693;9970.953049929725;9978.151857092156;9634.9518252409;9651.420914745138;9705.175060119898;9864.95067524665;9900.415933450686;41861.372079418834;42217.36673949893;42267.36598951018;42322;42521.78739106315;3271.4765637497885;3385.2890892912274;3440.6559344065645;3491.773034752758;3779.4708740776314;29447;29481.70518294811;30806.075817725505;30820.845895770603;30822.691773082206;2834.7448729614434;2835.432913417325;2841.829490230593;2923.006177899503;2997.220722612115;436216;436612;437000.81499592616;437239;439179;63019.68490157612;64803;64908.67545662336;64993;64994;68744.3125568748;68864.31135688678;68907.65546172237;68985.65507172432;69021.65489172522;15593.298301576457;17337.65324693499;17597.7360339595;17612.559686007953;17647.911760441373;11792.823107653392;11872.228305160137;11882;11913.880861191277;13184.934075329562;14967.711293769733;18881.339153129575;19554.902225489066;19563.706544401844;19600;6464.612123272619;8195.180481951757;8336.874946875801;8367.330613550901;8396.454230475;949.3734135470694;981.293468702533;993.3692105513052;1012.6152062216458;1103.2112039891515;29070.709292907224;29177.270568235963;29618;30333;30459.390812184076;1076.1659713721929;1124.2299025167786;1163.9941800291115;1164.7554013657227;1184.549871049013;14998.925005374904;15281.006734562217;15398.15310157952;15526.223688815515;15536.689266214613;618734;630072;633127;635393;637417;62431;62932;62985.68507157435;63025.68487157627;63286.68356658187;1332.9866701333056;1445.985540144585;1499.6250937265684;1500.6398464368692;1504.4207979927808;25631.487370252864;26620.866895665396;29691.96078137255;30361.24096897595;30781.538276926312;42407;49013;49308.520744377725;49335.75332123316;49391.753041234566;388769;389090;390038;390325;601129;33700.49449258312;34756.47865281972;34799.826000869834;34802.477962830075;34820.65179348174;47336.526634733214;48574.27138592995;48650.756746217456;48758;49155.754221228664;36610.8169459151;36632;36839.63160368469;37353;37618.623813761515;35319.29361412809;37255.627443725214;37428;37827.810860945516;38376.42435363416;37396.81301593475;37491.2501749958;37735.433968491045;37819.865404037926;37958;32637.836810815796;33750.83124584361;33786;33787;33831.830840846626;21035.579288414454;23464.296071117893;25170.74829251684;25356.619650705623;25428.474291542567 17:29:39 INFO - PROCESS | 1933 | |2;jquery.html;364.08251206958465;367.3938002296211;373.16597404800285;373.4435690820678;378.2831534242609;19747.1113799879;20424.89787551062;21317.57364852704;21507.03218355174;21834.672479912813;20720.171193152255;21005.579888402222;21505.56988860226;21624;21646.458838529044;5679.545636349082;5834.27071616048;5883.529317654598;5884.235049443566;5887.058070708687;5673.26247587815;5755.510781583549;5846.064629659255;5849;5874.0014197586515;5766.106253530709;5789.073748200289;5799.159121927339;5804.2744656917885;5804.419558044204;5635.718214089299;5676.176954341618;5762.1068734346245;5802.854928626776;5811.215485909391;4419.806652203887;4818.59041981432;5007.4491805901325;5026.673266237683;5039.924401133986;25671.74328256712;25876.094336698126;26214.86892565544;26277.868610657017;26320.473590528272;2125.9255926042515;2354.2701762453694;2377.5601513720017;2505.1232068775967;2511.2466260122073;12898.677533061655;14096.154230746188;14612.926935365254;15414.426245756578;15553.988990715681;1728.858953090954;1812.7190285505767;1858.1452531835373;1871.709884967832;1934.3906669399094;102801;105401.47299263532;106838.46580767124;107376;109466;10452.007059329351;10570.418626975435;10736.174850275473;10927.235093543535;11043;13172.341382930816;13258.933705331412;13307.135036222615;13307.467701292033;13380.531681391105;8654.740357789276;8838.425502342327;8843.425177363451;8951.776205594782;8982.191602755784;9073.81852362949;9087.772805679779;9118.726438206864;9133.269338452908;9302.348835581444;5269.050451333032;6420.74317027323;6420.775272865428;6424.486041116699;6440.194975628046;1819.4450692538903;1822.7630408046869;1824.9543761405805;1827.835494805474;1862.7299041638887;959.0792838874619;965.8937516873139;978.5645387802359;1072.4634794817964;1096.6326280696055;20683.965801709855;20689;21169.047392867356;21423.46441338948;21488.42138943337;906.6464079009191;937.9307589348149;999.7050869993369;1024.4928760263717;1033.9172866170688;9692.75768105803;11436.771264574661;11794.053981093024;11830.231034982871;11858.525658973544;651067;655485;658223;663665;666253;72674.63662681653;102207;125655.3717231408;131721;136625.0267613985;1016.694991502561;1045.7542477517777;1062.2776511971933;1063.6224140430036;1064.7178497698117;18641.44075677732;18906.43280701581;18976.62046759085;19087;19101.235950561822;53934.46065539451;53954;54234.101806436585;54813.725931371686;55022.44977550173;76995.61502192453;79719.60140199494;80392.59803700945;80700;81271.18728812873;7806.804829879071;7970.242826931432;7988.760337189894;8146.714864979697;8365;12880.742385152433;13107.672308192372;13210.075294729277;13435;13450.596482105553;11364.090872729996;11430.14273929442;11516.193866429605;11633.825492617787;11801.29192248468;9051.683191088281;10489.007088653132;11246.718832029264;11523.078153747512;11756.23584467007;10347.94826025865;11408.087353011904;11476.311421314414;11702.35637039971;11977.461014254553;8051.35589152878;8089.393295502743;8123.634436450492;8187.385946054189;8402.579871006548;10967.561297548009;11580.30518168879;11864.881351186377;11891.405429728306;11934.462949167135 17:29:39 INFO - PROCESS | 1933 | |3;mootools.html;1438.3671184678747;1565.608597850537;1594.0515393340959;1884.7455593494874;2026.9493262668423;8052.758417247477;8690.435121717092;8849.29205663547;8867.334949878768;8880.156385143417;8463.28062114721;8733.825323493526;8738.38831281809;8746.781330466725;8748;2185.4317877351923;2437.500312435955;2464.236086813089;2490.987545062272;2492.0654754467073;2504.8371855829405;2517.748225177486;2519.924402267935;2522.117258959368;2522.9116980905674;2428.611422172453;2478.7149477810012;2499.687539057618;2504.248725382387;2509.2848538166627;2450.5956517174645;2482.888270027853;2496.6005439129835;2499.650048993133;2500.549901017834;2097.2554743066144;2439.48770758141;2449.6937882764655;2465.987670061656;2500.4124030852736;8832.381733278673;8913.1086891311;8914.821703565956;8923.10768923109;8952.373333866632;5406.648567843077;5519.613627046108;5564.221009058735;5566.109422492382;5576.33084029915;3543.167355671415;3640.1263696712863;3704.4258139988347;3708.480812686199;3716.2939041582285;1018.9337693049928;1041.3075304922218;1048.6801525534709;1051.5898799468214;1059.8569193158903;12104.697382565419;12152.696182595417;12155.209911355734;12161.270323780689;12169.452374643162;4758.724327934593;4811;4817.566419022305;4846.854594362104;4860.416749990024;10195.235357348229;10202.234832387452;10212;10217.386956782617;10238.12975897057;5423.403425623178;5440.3743569489225;5441.183822426668;5441.483059109379;5448.291722076105;4493.505714371417;4630.884227894262;4848.466668666444;4986.177280748709;4993.850184494471;3395.762296639261;3919.9020024499046;3998.080441498472;4004.539477960072;4036.354183330653;1321.914075585084;1343.8320209973754;1352.6734017489903;1355.8034085057611;1359.463012110211;1192.9582464613698;1195.748892732536;1267.2206592945272;1299.246437066499;1383.3221721356665;6977.651117444209;7962.800929976681;8122.7157049502985;8139.83720325602;8193.79515512117;521.8173639226317;530.1649901405225;538.504575790266;541.5613353183934;545.2393910494917;6104.755809767648;6126.785562505291;6188.133661287423;6204.720787564571;6221.3156552779155;10298.382097074049;10637.627683031056;10641.627543035956;10722.249442538947;10738.194635402377;9910.405375677483;10205.948970255102;10515.84226236607;10523.894761052292;10585;8215.548144851971;8286.378521610903;8328.916710832935;8329.125441828643;8346.749597511964;6572.901406478811;7734.381249499914;7810.336121429742;7859;7902.762917112495;9278.72163835086;9285.72142835716;9335.06649335061;9457;9523;9447.24422046221;9682.70951871445;9708.077732615391;9956.153726933002;9964.750881228027;6764.932350676627;6960.756373526902;7147.356737893615;7546.622668866425;7604.50570712924;8171.978502687164;8172.6730930762105;8207.9589602054;8224.465409748347;8225.136360682282;6637.867242655217;7062.39969602569;7211.4230861532005;7323.12122545298;7437.739679111205;7120.893186602309;7220.711171553289;7268.0914885639295;7303.233160518069;7353.7058517660835;6911.17065952089;7590.316871481593;7723.459357844897;7727.265909738566;7742.444993152359;5558.499735023867;7010.544314619533;7012.228654848064;7014.649267536704;7035.964820175866;6980.127484064492;7104.644767761694;7114.50198486101;7126.251743566851;7128.607926564089 17:29:39 INFO - PROCESS | 1933 | |4;prototype.html;327.24733113838175;329.7526854858854;334.9145967778216;335.3962866839688;342.59915898398873;6423.614583125016;6489.1888513935755;6498.740050397979;6507.967460162693;6526.28210896801;6396.776112836052;6399.072134540489;6458.160439142905;6481.481481481482;6509.576877502959;4641.8839529011875;4704.717716936994;4761.166795810736;4869.951300486994;4879.853604391874;4817.084753896748;4829.034193161364;4836.854894353175;4856.514348565133;4867.196912509432;4795.808167673306;4807.951920480803;4817.253325734517;4818.518148185189;4826.831060912868;4576.427946506687;4614.792334344946;4701.835435759732;4745.1695953208055;4746.240601503743;4053.8175782089875;4071;4078.9592104078874;4085.775282359469;4091.3453847384276;6174.104754810573;6193.969030154865;6197.504199664016;6201.81394558164;6232.34560371159;5592.4407559244155;5595.8808238352085;5599.300087489064;5607.551395888319;5627.5779316551425;6838.931610683929;6840.008198811194;6849.589024658487;6853.314668533157;6853.9314606853795;4318.4170137031415;4476.082403107388;4511.819527218908;4531.52418996004;4544.454665440168;7162.964185179093;7292.088488938883;7307.561546307238;7307.561546307238;7312.8171795705;4586.518415566385;4589.265717485253;4592.288195329663;4592.586667199901;4597.95402045982;4639.675222734444;4640.396748422683;4641.651876109306;4644.907101858012;4652.860414187579;5487.64330318528;5501.339839219239;5510.448955104457;5518.448155184449;5518.696471694015;6638.6390789887955;6915.827104322331;6954.061201737701;6986.056882320923;6986.336298051677;1592.4983630156464;1607.3490236454254;1617.7249867522548;1618.8623966962705;1621.5946013496625;971.455984648599;1008.4251976373397;1026.779242462874;1035.471909326249;1058.063613701864;6433.099366088752;6537.705803238866;6550.2794692583775;6589.439897608757;6617.205935287796;7238.746643867439;7241.710331586678;7248.202697703248;7255.129384473897;7256.4557658175845;6563.638999855054;6566.6388348641285;6579.572327798678;6581.04574836646;6581.440577550866;3295.7692961492944;3775.414810704345;3819.2743378757946;3828.693704503633;3828.789416582115;6240.937590624127;7228.855422891513;7398.149212840593;7607.543547387175;7658.157602663702;7429.962850185714;7462.552246865205;7481.812954676177;7486.176520582731;7519.8496030079095;6088.51291896656;7592.354649854824;7602.733904313433;7607.505512141804;7618.352440042548;5832.912506312494;5834.591578589458;5914.260717410324;7010.299237905131;7253.782386528413;6975.651217439209;7118.181409138016;7126.679299431642;7158.785236442915;7177.425805935617;7529.171791103084;7592.696292148473;7595.240475952361;7596.772096837104;7608.087029556488;4547.454305483363;4609.216433206296;4609.492955774929;4610.124076425468;4618.491965883817;7174.713011479483;7184.389326907062;7190.784276471714;7192.388646965067;7200;5617.382087970402;6672.766453174309;6966.1988871280455;6992.510524263253;6993.580385176702;6920.204176519564;6951.20061192949;6957.478189135936;6964.199117101598;6977.441804655717;6784.457243420613;6800.353966373186;6801.829954251183;6802.8639427212165;6808.289482232294;5650.547956163415;6682.899756503753;6938.722451101899;6945.444364450933;6948.583085014915;6610.173728283965;6778.084958530535;6908.689108990208;6911.5853048817235;6916.239213686591 17:29:39 INFO - PROCESS | 1933 | |5;yui.html;716.74197288976;763.7937756805662;766.5898744171866;780.5238804329358;826.5784449930534;15187.936844420896;15305.84694153058;15346.846531534682;15420.614484637876;15444.227788610553;14698.191599462025;14782.965192436533;14792.482263120794;14796.408143674267;14810.259487025633;762.8741257692474;769.2230846844672;933.2673851026946;954.2747511890943;972.7422233108232;955.5031383680482;960.7790208252106;963.2005435488528;967.2310513142033;967.9467629280387;1021.8927012663675;1025.8820235672881;1026.0611540440489;1028.0541901450683;1028.588564574169;793.2107552984788;802.9036515618105;985.6698006167942;1013.9543720532594;1020.5815615597606;745.4483682075279;746.3208480282916;746.5856449670431;747.3162056718096;749.4454103963028;15065.849341506555;15105.622359441102;15164.696706065928;15176.089434633846;15194.848051519453;12617.179883307555;12687.302198379086;12743.936280318632;12849.173181899967;13091.279979601119;9967.75080622983;9993.900060999442;10169.288149829516;10698.465076746132;10850.674479765541;3590.1024743814046;3657.835397407123;3676.3750162472443;3679.816009199529;3682.0426689061037;84001.73997390045;84195;84514.15485845186;84907.57546212229;85156.14843851545;9339.813203735886;9431.717048488556;9584.137427631547;9667.226621870233;9747.56135973883;17884.374046908295;18707.90646046761;20876.895615521826;21333.893330533247;21348.679769803464;7476.1776204617445;7562.357199637982;7634.427417943676;7654.272844079804;7914.841703165905;4063.6139566741113;4135.91728165435;4170.520390155171;4185.162967406531;4262.893427664271;3621.909452263662;3661.2494438640547;3663.0292972362345;3667.1198912261398;3669.101070237809;610.8747706720112;638.7572722365471;659.36700767263;673.4780545077506;691.4364792693939;530.9628326017219;543.570579242402;558.8602849287678;606.5390303369383;627.6014730646073;7842.137364889858;8087.514749115072;8108.513489190667;8144.104148543655;8330.8333833323;593.1606776411415;614.241411856357;621.3320680268729;621.7699451202993;635.7743001234587;3625.4743062255825;3677.2645470905927;3769.3215221260434;4010.598940106024;4015.377616469452;94788.57817132749;96012.51993740126;96267.51866240765;97399;99295;80895;81110.37779244382;81873.18126818775;82941;83784;70591.64704176446;71485.64257178681;71542.56914861778;71890;72792.54414911671;7694.884576731465;7724.845503089794;7863.606819659109;7915.406344524068;8012;48918.75540622274;49518.76203094952;49904.75047624738;50458;51627.70930726762;63548.68225659027;68933;69091.65454172697;69524.6523767378;70441.29558704347;9241.412404526744;9932.404055756677;10031.097201251923;11007.83488247693;11320.490577924178;12026.338551379407;12053.63839084829;12269.466316710412;12404;12446.25322480654;11258.7748245033;11592.884071159518;11703.063754899758;11706.707332316419;12406.069544784357;11081.612143574936;11135.777284454103;11147.386893720923;11201.38392388394;11531.942340288246;11210.66368008961;11219.495122719334;11288.717782055513;11503.256338362697;11567.652970410902;9561.760955976157;9600.951995239979;9648.614055437703;9913.603455861974;9999.400035997864;9277.109632238202;9586.376885502421;9611.567479463301;9632.181264592587;9724.27067969891 17:29:39 INFO - PROCESS | 1933 | __end_tp_report 17:29:39 INFO - PROCESS | 1933 | __start_cc_report 17:29:39 INFO - PROCESS | 1933 | _x_x_mozilla_cycle_collect,1119 17:29:39 INFO - PROCESS | 1933 | __end_cc_report 17:29:39 INFO - PROCESS | 1933 | __startTimestamp1457659779197__endTimestamp 17:29:39 INFO - PROCESS | 1933 | 17:29:39 INFO - PROCESS | 1933 | ------- Summary: start ------- 17:29:39 INFO - PROCESS | 1933 | Number of tests: 6 17:29:39 INFO - PROCESS | 1933 | 17:29:39 INFO - PROCESS | 1933 | [#0] dojo.html Cycles:165 Average:5722.84 Median:5941.73 stddev:637.25 (10.7%) stddev-sans-first:613.44 17:29:39 INFO - PROCESS | 1933 | Values: 3436.2 3470.4 3510.4 3520.0 3560.0 5598.1 5630.9 5643.5 5664.1 5689.0 5656.1 5660.5 5694.7 5785.0 5805.3 5062.4 5105.2 5106.2 5114.5 5165.8 5234.9 5274.8 5302.9 5309.9 5353.0 5065.3 5078.9 5166.5 5170.4 5218.1 5147.1 5160.1 5180.1 5181.9 5184.4 5077.2 5104.8 5138.0 5150.6 5155.3 5489.9 5573.1 5595.9 5690.5 5690.8 6207.5 6221.8 6227.7 6246.6 6252.7 6227.7 6275.7 6286.0 6303.1 6303.7 5605.0 5642.6 5704.7 5713.8 5717.7 6212.5 6290.9 6294.6 6301.7 6308.6 6091.5 6152.0 6167.0 6169.5 6186.1 6109.7 6218.8 6272.2 6286.2 6289.2 6136.2 6196.8 6203.0 6220.9 6230.3 6212.2 6223.7 6245.7 6251.7 6263.8 4791.5 4809.4 4862.9 4894.6 4904.9 4317.8 4347.5 4364.5 4408.3 4418.3 4836.9 5663.8 5670.1 5701.9 5733.2 6105.9 6208.3 6265.1 6290.5 6306.4 5656.8 5703.5 5709.1 5715.6 5763.1 5330.8 5339.6 5345.3 5345.9 5350.2 6191.4 6197.6 6292.3 6296.0 6328.4 6241.4 6279.7 6282.0 6286.0 6293.0 6236.9 6283.4 6295.7 6295.9 6302.5 6022.9 6117.4 6140.1 6179.9 6189.7 6091.7 6190.8 6221.1 6253.5 6261.4 6057.7 6079.8 6080.5 6085.7 6116.1 5928.9 6030.4 6052.0 6108.8 6121.0 5925.0 5941.6 5952.8 5954.6 6004.1 6059.4 6059.5 6116.5 6123.7 6142.1 5757.1 5848.9 5868.0 5936.3 5941.7 17:29:39 INFO - PROCESS | 1933 | 17:29:39 INFO - PROCESS | 1933 | [#1] ext.html Cycles:180 Average:64981.00 Median:388929.50 stddev:136282.77 (35.0%) stddev-sans-first:136578.95 17:29:39 INFO - PROCESS | 1933 | Values: 445.3 575.3 577.0 631.2 649.1 26726.9 39787.4 40211.6 40236.0 40354.8 42711.0 43336.0 43391.0 43435.8 43667.8 9579.2 9846.2 9848.1 9854.5 9856.3 8629.4 9713.7 9743.7 9869.8 9886.4 9898.7 9980.1 9991.0 10002.3 10013.3 9883.5 9957.8 9962.1 9971.0 9978.2 9635.0 9651.4 9705.2 9865.0 9900.4 41861.4 42217.4 42267.4 42322.0 42521.8 3271.5 3385.3 3440.7 3491.8 3779.5 29447.0 29481.7 30806.1 30820.8 30822.7 2834.7 2835.4 2841.8 2923.0 2997.2 436216.0 436612.0 437000.8 437239.0 439179.0 63019.7 64803.0 64908.7 64993.0 64994.0 68744.3 68864.3 68907.7 68985.7 69021.7 15593.3 17337.7 17597.7 17612.6 17647.9 11792.8 11872.2 11882.0 11913.9 13184.9 14967.7 18881.3 19554.9 19563.7 19600.0 6464.6 8195.2 8336.9 8367.3 8396.5 949.4 981.3 993.4 1012.6 1103.2 29070.7 29177.3 29618.0 30333.0 30459.4 1076.2 1124.2 1164.0 1164.8 1184.5 14998.9 15281.0 15398.2 15526.2 15536.7 618734.0 630072.0 633127.0 635393.0 637417.0 62431.0 62932.0 62985.7 63025.7 63286.7 1333.0 1446.0 1499.6 1500.6 1504.4 25631.5 26620.9 29692.0 30361.2 30781.5 42407.0 49013.0 49308.5 49335.8 49391.8 388769.0 389090.0 390038.0 390325.0 601129.0 33700.5 34756.5 34799.8 34802.5 34820.7 47336.5 48574.3 48650.8 48758.0 49155.8 36610.8 36632.0 36839.6 37353.0 37618.6 35319.3 37255.6 37428.0 37827.8 38376.4 37396.8 37491.3 37735.4 37819.9 37958.0 32637.8 33750.8 33786.0 33787.0 33831.8 21035.6 23464.3 25170.7 25356.6 25428.5 17:29:39 INFO - PROCESS | 1933 | 17:29:39 INFO - PROCESS | 1933 | [#2] jquery.html Cycles:180 Average:36334.97 Median:21740.57 stddev:108965.25 (501.2%) stddev-sans-first:109237.45 17:29:39 INFO - PROCESS | 1933 | Values: 364.1 367.4 373.2 373.4 378.3 19747.1 20424.9 21317.6 21507.0 21834.7 20720.2 21005.6 21505.6 21624.0 21646.5 5679.5 5834.3 5883.5 5884.2 5887.1 5673.3 5755.5 5846.1 5849.0 5874.0 5766.1 5789.1 5799.2 5804.3 5804.4 5635.7 5676.2 5762.1 5802.9 5811.2 4419.8 4818.6 5007.4 5026.7 5039.9 25671.7 25876.1 26214.9 26277.9 26320.5 2125.9 2354.3 2377.6 2505.1 2511.2 12898.7 14096.2 14612.9 15414.4 15554.0 1728.9 1812.7 1858.1 1871.7 1934.4 102801.0 105401.5 106838.5 107376.0 109466.0 10452.0 10570.4 10736.2 10927.2 11043.0 13172.3 13258.9 13307.1 13307.5 13380.5 8654.7 8838.4 8843.4 8951.8 8982.2 9073.8 9087.8 9118.7 9133.3 9302.3 5269.1 6420.7 6420.8 6424.5 6440.2 1819.4 1822.8 1825.0 1827.8 1862.7 959.1 965.9 978.6 1072.5 1096.6 20684.0 20689.0 21169.0 21423.5 21488.4 906.6 937.9 999.7 1024.5 1033.9 9692.8 11436.8 11794.1 11830.2 11858.5 651067.0 655485.0 658223.0 663665.0 666253.0 72674.6 102207.0 125655.4 131721.0 136625.0 1016.7 1045.8 1062.3 1063.6 1064.7 18641.4 18906.4 18976.6 19087.0 19101.2 53934.5 53954.0 54234.1 54813.7 55022.4 76995.6 79719.6 80392.6 80700.0 81271.2 7806.8 7970.2 7988.8 8146.7 8365.0 12880.7 13107.7 13210.1 13435.0 13450.6 11364.1 11430.1 11516.2 11633.8 11801.3 9051.7 10489.0 11246.7 11523.1 11756.2 10347.9 11408.1 11476.3 11702.4 11977.5 8051.4 8089.4 8123.6 8187.4 8402.6 10967.6 11580.3 11864.9 11891.4 11934.5 17:29:39 INFO - PROCESS | 1933 | 17:29:39 INFO - PROCESS | 1933 | [#3] mootools.html Cycles:180 Average:6002.17 Median:5440.78 stddev:3184.90 (58.5%) stddev-sans-first:3175.36 17:29:39 INFO - PROCESS | 1933 | Values: 1438.4 1565.6 1594.1 1884.7 2026.9 8052.8 8690.4 8849.3 8867.3 8880.2 8463.3 8733.8 8738.4 8746.8 8748.0 2185.4 2437.5 2464.2 2491.0 2492.1 2504.8 2517.7 2519.9 2522.1 2522.9 2428.6 2478.7 2499.7 2504.2 2509.3 2450.6 2482.9 2496.6 2499.7 2500.5 2097.3 2439.5 2449.7 2466.0 2500.4 8832.4 8913.1 8914.8 8923.1 8952.4 5406.6 5519.6 5564.2 5566.1 5576.3 3543.2 3640.1 3704.4 3708.5 3716.3 1018.9 1041.3 1048.7 1051.6 1059.9 12104.7 12152.7 12155.2 12161.3 12169.5 4758.7 4811.0 4817.6 4846.9 4860.4 10195.2 10202.2 10212.0 10217.4 10238.1 5423.4 5440.4 5441.2 5441.5 5448.3 4493.5 4630.9 4848.5 4986.2 4993.9 3395.8 3919.9 3998.1 4004.5 4036.4 1321.9 1343.8 1352.7 1355.8 1359.5 1193.0 1195.7 1267.2 1299.2 1383.3 6977.7 7962.8 8122.7 8139.8 8193.8 521.8 530.2 538.5 541.6 545.2 6104.8 6126.8 6188.1 6204.7 6221.3 10298.4 10637.6 10641.6 10722.2 10738.2 9910.4 10205.9 10515.8 10523.9 10585.0 8215.5 8286.4 8328.9 8329.1 8346.7 6572.9 7734.4 7810.3 7859.0 7902.8 9278.7 9285.7 9335.1 9457.0 9523.0 9447.2 9682.7 9708.1 9956.2 9964.8 6764.9 6960.8 7147.4 7546.6 7604.5 8172.0 8172.7 8208.0 8224.5 8225.1 6637.9 7062.4 7211.4 7323.1 7437.7 7120.9 7220.7 7268.1 7303.2 7353.7 6911.2 7590.3 7723.5 7727.3 7742.4 5558.5 7010.5 7012.2 7014.6 7036.0 6980.1 7104.6 7114.5 7126.3 7128.6 17:29:39 INFO - PROCESS | 1933 | 17:29:39 INFO - PROCESS | 1933 | [#4] prototype.html Cycles:180 Average:5664.50 Median:6469.82 stddev:1806.19 (27.9%) stddev-sans-first:1766.27 17:29:39 INFO - PROCESS | 1933 | Values: 327.2 329.8 334.9 335.4 342.6 6423.6 6489.2 6498.7 6508.0 6526.3 6396.8 6399.1 6458.2 6481.5 6509.6 4641.9 4704.7 4761.2 4870.0 4879.9 4817.1 4829.0 4836.9 4856.5 4867.2 4795.8 4808.0 4817.3 4818.5 4826.8 4576.4 4614.8 4701.8 4745.2 4746.2 4053.8 4071.0 4079.0 4085.8 4091.3 6174.1 6194.0 6197.5 6201.8 6232.3 5592.4 5595.9 5599.3 5607.6 5627.6 6838.9 6840.0 6849.6 6853.3 6853.9 4318.4 4476.1 4511.8 4531.5 4544.5 7163.0 7292.1 7307.6 7307.6 7312.8 4586.5 4589.3 4592.3 4592.6 4598.0 4639.7 4640.4 4641.7 4644.9 4652.9 5487.6 5501.3 5510.4 5518.4 5518.7 6638.6 6915.8 6954.1 6986.1 6986.3 1592.5 1607.3 1617.7 1618.9 1621.6 971.5 1008.4 1026.8 1035.5 1058.1 6433.1 6537.7 6550.3 6589.4 6617.2 7238.7 7241.7 7248.2 7255.1 7256.5 6563.6 6566.6 6579.6 6581.0 6581.4 3295.8 3775.4 3819.3 3828.7 3828.8 6240.9 7228.9 7398.1 7607.5 7658.2 7430.0 7462.6 7481.8 7486.2 7519.8 6088.5 7592.4 7602.7 7607.5 7618.4 5832.9 5834.6 5914.3 7010.3 7253.8 6975.7 7118.2 7126.7 7158.8 7177.4 7529.2 7592.7 7595.2 7596.8 7608.1 4547.5 4609.2 4609.5 4610.1 4618.5 7174.7 7184.4 7190.8 7192.4 7200.0 5617.4 6672.8 6966.2 6992.5 6993.6 6920.2 6951.2 6957.5 6964.2 6977.4 6784.5 6800.4 6801.8 6802.9 6808.3 5650.5 6682.9 6938.7 6945.4 6948.6 6610.2 6778.1 6908.7 6911.6 6916.2 17:29:39 INFO - PROCESS | 1933 | 17:29:39 INFO - PROCESS | 1933 | [#5] yui.html Cycles:180 Average:18713.11 Median:621.55 stddev:26690.47 (4294.2%) stddev-sans-first:26731.13 17:29:39 INFO - PROCESS | 1933 | Values: 716.7 763.8 766.6 780.5 826.6 15187.9 15305.8 15346.8 15420.6 15444.2 14698.2 14783.0 14792.5 14796.4 14810.3 762.9 769.2 933.3 954.3 972.7 955.5 960.8 963.2 967.2 967.9 1021.9 1025.9 1026.1 1028.1 1028.6 793.2 802.9 985.7 1014.0 1020.6 745.4 746.3 746.6 747.3 749.4 15065.8 15105.6 15164.7 15176.1 15194.8 12617.2 12687.3 12743.9 12849.2 13091.3 9967.8 9993.9 10169.3 10698.5 10850.7 3590.1 3657.8 3676.4 3679.8 3682.0 84001.7 84195.0 84514.2 84907.6 85156.1 9339.8 9431.7 9584.1 9667.2 9747.6 17884.4 18707.9 20876.9 21333.9 21348.7 7476.2 7562.4 7634.4 7654.3 7914.8 4063.6 4135.9 4170.5 4185.2 4262.9 3621.9 3661.2 3663.0 3667.1 3669.1 610.9 638.8 659.4 673.5 691.4 531.0 543.6 558.9 606.5 627.6 7842.1 8087.5 8108.5 8144.1 8330.8 593.2 614.2 621.3 621.8 635.8 3625.5 3677.3 3769.3 4010.6 4015.4 94788.6 96012.5 96267.5 97399.0 99295.0 80895.0 81110.4 81873.2 82941.0 83784.0 70591.6 71485.6 71542.6 71890.0 72792.5 7694.9 7724.8 7863.6 7915.4 8012.0 48918.8 49518.8 49904.8 50458.0 51627.7 63548.7 68933.0 69091.7 69524.7 70441.3 9241.4 9932.4 10031.1 11007.8 11320.5 12026.3 12053.6 12269.5 12404.0 12446.3 11258.8 11592.9 11703.1 11706.7 12406.1 11081.6 11135.8 11147.4 11201.4 11531.9 11210.7 11219.5 11288.7 11503.3 11567.7 9561.8 9601.0 9648.6 9913.6 9999.4 9277.1 9586.4 9611.6 9632.2 9724.3 17:29:39 INFO - PROCESS | 1933 | -------- Summary: end -------- 17:29:39 INFO - PROCESS | 1933 | 17:29:39 INFO - TEST-INFO | 1933: exit 0 17:29:39 INFO - TEST-OK | dromaeo_css | took 1113581ms 17:29:39 INFO - TEST-START | kraken 17:29:39 INFO - operating with platform_type : mac_ 17:29:39 INFO - Initialising browser for kraken test... 17:29:39 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/tmpjhtnli/profile http://localhost:50863/getInfo.html) 17:29:42 INFO - PROCESS | 1938 | __metrics Screen width/height:1600/1200 17:29:42 INFO - PROCESS | 1938 | colorDepth:24 17:29:42 INFO - PROCESS | 1938 | Browser inner width/height: 1024/689 17:29:42 INFO - PROCESS | 1938 | __metrics 17:29:42 INFO - PROCESS | 1938 | 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" 17:29:42 ERROR - PROCESS | 1938 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:29:42 INFO - TEST-INFO | 1938: exit 0 17:29:42 INFO - Browser initialized. 17:29:42 INFO - Running cycle 1/1 for kraken test... 17:29:42 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/tmpjhtnli/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:54 INFO - PROCESS | 1940 | RSS: Main: 242413568 17:29:54 INFO - PROCESS | 1940 | 17:29:57 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:50863/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50863/tests/kraken/driver.html?testName=audio-beat-detection) 17:29:58 INFO - PROCESS | 1940 | RSS: Main: 289640448 17:29:58 INFO - PROCESS | 1940 | 17:30:00 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:50863/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50863/tests/kraken/driver.html?testName=audio-dft) 17:30:01 INFO - PROCESS | 1940 | RSS: Main: 300068864 17:30:01 INFO - PROCESS | 1940 | 17:30:04 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:50863/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50863/tests/kraken/driver.html?testName=audio-fft) 17:30:05 INFO - PROCESS | 1940 | RSS: Main: 285757440 17:30:05 INFO - PROCESS | 1940 | 17:30:07 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:50863/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50863/tests/kraken/driver.html?testName=audio-oscillator) 17:30:07 INFO - PROCESS | 1940 | RSS: Main: 289808384 17:30:07 INFO - PROCESS | 1940 | 17:30:09 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:50863/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50863/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:30:10 INFO - PROCESS | 1940 | RSS: Main: 290983936 17:30:10 INFO - PROCESS | 1940 | 17:30:13 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:50863/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50863/tests/kraken/driver.html?testName=imaging-darkroom) 17:30:13 INFO - PROCESS | 1940 | RSS: Main: 289931264 17:30:13 INFO - PROCESS | 1940 | 17:30:16 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:50863/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50863/tests/kraken/driver.html?testName=imaging-desaturate) 17:30:17 INFO - PROCESS | 1940 | RSS: Main: 292335616 17:30:17 INFO - PROCESS | 1940 | 17:30:19 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:50863/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50863/tests/kraken/driver.html?testName=json-parse-financial) 17:30:20 INFO - PROCESS | 1940 | RSS: Main: 289935360 17:30:20 INFO - PROCESS | 1940 | 17:30:22 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:50863/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50863/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:30:22 INFO - PROCESS | 1940 | RSS: Main: 326889472 17:30:22 INFO - PROCESS | 1940 | 17:30:24 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:50863/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50863/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:30:25 INFO - PROCESS | 1940 | RSS: Main: 325971968 17:30:25 INFO - PROCESS | 1940 | 17:30:27 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:50863/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50863/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:30:27 INFO - PROCESS | 1940 | RSS: Main: 331280384 17:30:27 INFO - PROCESS | 1940 | 17:30:30 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:50863/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:30:30 INFO - PROCESS | 1940 | RSS: Main: 332300288 17:30:30 INFO - PROCESS | 1940 | 17:30:33 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:50863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:30:34 INFO - PROCESS | 1940 | RSS: Main: 334041088 17:30:34 INFO - PROCESS | 1940 | 17:30:35 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:50863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50863/tests/kraken/driver.html?testName=ai-astar) 17:30:36 INFO - PROCESS | 1940 | RSS: Main: 394084352 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | __start_tp_report 17:30:36 INFO - PROCESS | 1940 | _x_x_mozilla_page_load 17:30:36 INFO - PROCESS | 1940 | _x_x_mozilla_page_load_details 17:30:36 INFO - PROCESS | 1940 | |i|pagename|runs| 17:30:36 INFO - PROCESS | 1940 | |0;ai-astar;109;106;111;109;112;113;116;112;110;112 17:30:36 INFO - PROCESS | 1940 | |1;audio-beat-detection;157;120;143;160;114;141;139;119;160;117 17:30:36 INFO - PROCESS | 1940 | |2;audio-dft;184;182;186;184;185;187;186;186;181;179 17:30:36 INFO - PROCESS | 1940 | |3;audio-fft;82;75;87;78;57;60;58;81;76;56 17:30:36 INFO - PROCESS | 1940 | |4;audio-oscillator;95;93;131;81;79;86;110;77;78;110 17:30:36 INFO - PROCESS | 1940 | |5;imaging-gaussian-blur;87;84;87;85;88;87;94;84;87;84 17:30:36 INFO - PROCESS | 1940 | |6;imaging-darkroom;96;94;92;93;106;149;92;93;92;92 17:30:36 INFO - PROCESS | 1940 | |7;imaging-desaturate;88;88;85;97;141;120;86;87;83;87 17:30:36 INFO - PROCESS | 1940 | |8;json-parse-financial;57;56;56;53;54;53;55;64;56;52 17:30:36 INFO - PROCESS | 1940 | |9;json-stringify-tinderbox;65;73;70;74;71;68;67;68;67;68 17:30:36 INFO - PROCESS | 1940 | |10;stanford-crypto-aes;82;83;82;82;82;81;82;81;84;84 17:30:36 INFO - PROCESS | 1940 | |11;stanford-crypto-ccm;120;121;128;131;125;130;130;130;118;126 17:30:36 INFO - PROCESS | 1940 | |12;stanford-crypto-pbkdf2;131;123;140;137;137;128;138;144;172;178 17:30:36 INFO - PROCESS | 1940 | |13;stanford-crypto-sha256-iterative;66;68;67;67;67;67;67;70;82;96 17:30:36 INFO - PROCESS | 1940 | __end_tp_report 17:30:36 INFO - PROCESS | 1940 | __start_cc_report 17:30:36 INFO - PROCESS | 1940 | _x_x_mozilla_cycle_collect,1220 17:30:36 INFO - PROCESS | 1940 | __end_cc_report 17:30:36 INFO - PROCESS | 1940 | __startTimestamp1457659836092__endTimestamp 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | ------- Summary: start ------- 17:30:36 INFO - PROCESS | 1940 | Number of tests: 14 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.71 (2.4%) stddev-sans-first:2.77 17:30:36 INFO - PROCESS | 1940 | Values: 109.0 106.0 111.0 109.0 112.0 113.0 116.0 112.0 110.0 112.0 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:142.00 stddev:18.43 (13.0%) stddev-sans-first:18.07 17:30:36 INFO - PROCESS | 1940 | Values: 157.0 120.0 143.0 160.0 114.0 141.0 139.0 119.0 160.0 117.0 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | [#2] audio-dft Cycles:10 Average:184.00 Median:185.50 stddev:2.58 (1.4%) stddev-sans-first:2.74 17:30:36 INFO - PROCESS | 1940 | Values: 184.0 182.0 186.0 184.0 185.0 187.0 186.0 186.0 181.0 179.0 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | [#3] audio-fft Cycles:10 Average:71.00 Median:77.00 stddev:11.92 (15.5%) stddev-sans-first:11.96 17:30:36 INFO - PROCESS | 1940 | Values: 82.0 75.0 87.0 78.0 57.0 60.0 58.0 81.0 76.0 56.0 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:80.00 stddev:17.91 (22.4%) stddev-sans-first:18.99 17:30:36 INFO - PROCESS | 1940 | Values: 95.0 93.0 131.0 81.0 79.0 86.0 110.0 77.0 78.0 110.0 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:87.00 stddev:2.98 (3.4%) stddev-sans-first:3.16 17:30:36 INFO - PROCESS | 1940 | Values: 87.0 84.0 87.0 85.0 88.0 87.0 94.0 84.0 87.0 84.0 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:92.50 stddev:17.77 (19.2%) stddev-sans-first:18.79 17:30:36 INFO - PROCESS | 1940 | Values: 96.0 94.0 92.0 93.0 106.0 149.0 92.0 93.0 92.0 92.0 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:87.00 stddev:19.10 (21.9%) stddev-sans-first:20.02 17:30:36 INFO - PROCESS | 1940 | Values: 88.0 88.0 85.0 97.0 141.0 120.0 86.0 87.0 83.0 87.0 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:3.37 (6.0%) stddev-sans-first:3.54 17:30:36 INFO - PROCESS | 1940 | Values: 57.0 56.0 56.0 53.0 54.0 53.0 55.0 64.0 56.0 52.0 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:2.85 (4.1%) stddev-sans-first:2.60 17:30:36 INFO - PROCESS | 1940 | Values: 65.0 73.0 70.0 74.0 71.0 68.0 67.0 68.0 67.0 68.0 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:1.06 (1.3%) stddev-sans-first:1.12 17:30:36 INFO - PROCESS | 1940 | Values: 82.0 83.0 82.0 82.0 82.0 81.0 82.0 81.0 84.0 84.0 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:129.00 stddev:4.75 (3.7%) stddev-sans-first:4.53 17:30:36 INFO - PROCESS | 1940 | Values: 120.0 121.0 128.0 131.0 125.0 130.0 130.0 130.0 118.0 126.0 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:139.00 stddev:18.08 (13.0%) stddev-sans-first:18.66 17:30:36 INFO - PROCESS | 1940 | Values: 131.0 123.0 140.0 137.0 137.0 128.0 138.0 144.0 172.0 178.0 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - PROCESS | 1940 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:67.50 stddev:9.75 (14.4%) stddev-sans-first:10.12 17:30:36 INFO - PROCESS | 1940 | Values: 66.0 68.0 67.0 67.0 67.0 67.0 67.0 70.0 82.0 96.0 17:30:36 INFO - PROCESS | 1940 | -------- Summary: end -------- 17:30:36 INFO - PROCESS | 1940 | 17:30:36 INFO - TEST-INFO | 1940: exit 0 17:30:36 INFO - TEST-OK | kraken | took 57083ms 17:30:36 INFO - SUITE-END | took 1170s 17:30:37 INFO - Completed test suite (00:19:31) 17:30:37 INFO - javascript benchmark 17:30:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3436.2096717754916, 3470.357983773002, 3510.385682505561, 3520.049586611615, 3560.0, 5598.1322894951345, 5630.943690563093, 5643.492085712285, 5664.065429204182, 5688.9999999999945, 5656.066748986423, 5660.518855897243, 5694.715264236782, 5785.016547186978, 5805.303363596375, 5062.392512898439, 5105.208692652635, 5106.208537676647, 5114.488551144875, 5165.845024649267, 5234.895302093956, 5274.789008439677, 5302.92045619316, 5309.920351194735, 5353.03645343838, 5065.316182315377, 5078.873028174288, 5166.483351664822, 5170.431252562215, 5218.086834803932, 5147.073526765181, 5160.14857548504, 5180.119379705421, 5181.870453238662, 5184.403793563751, 5077.238414237857, 5104.770285337168, 5138.049460849717, 5150.61370397218, 5155.252488389163, 5489.890202195974, 5573.108302671553, 5595.916061259044, 5690.487856092972, 5690.800821971253, 6207.503399728011, 6221.751129954796, 6227.688615569204, 6246.625202487865, 6252.687365631746, 6227.688615569204, 6275.7489700411925, 6285.96857015712, 6303.086052522359, 6303.716332765037, 5604.971975140098, 5642.633228840071, 5704.714764261853, 5713.771449142029, 5717.685527295997, 6212.502999760009, 6290.874182516324, 6294.622322660563, 6301.684915754286, 6308.621482710961, 6091.51267898567, 6152.046432802923, 6166.969165154235, 6169.537284703665, 6186.10301506288, 6109.708332504907, 6218.782342617987, 6272.153259310026, 6286.151369565142, 6289.245290565162, 6136.20229370179, 6196.845078873064, 6203.0, 6220.906686399708, 6230.252369715572, 6212.223472065992, 6223.719932603044, 6245.687715614201, 6251.687415629201, 6263.812085637438, 4791.496892826203, 4809.398825146856, 4862.902741945141, 4894.559489645878, 4904.926426103611, 4317.827286908551, 4347.478302603708, 4364.454443194601, 4408.294672852328, 4418.315161150027, 4836.854894353175, 5663.801766938137, 5670.064439367458, 5701.885962280814, 5733.168690539848, 6105.908411373833, 6208.286047104551, 6265.091561723616, 6290.496760259169, 6306.369363063749, 5656.8020119295625, 5703.458171473703, 5709.115087161496, 5715.599908006399, 5763.077907534775, 5330.840074797762, 5339.5728341732565, 5345.33183352081, 5345.946540534623, 5350.197470379474, 6191.4118158774845, 6197.566170368031, 6292.339304373158, 6296.0, 6328.367163283727, 6241.375862413904, 6279.717412716347, 6281.96859015702, 6286.025666021774, 6292.993121100602, 6236.906446403217, 6283.434490895841, 6295.716692748746, 6295.929691952288, 6302.527310451643, 6022.939770602413, 6117.418845209698, 6140.109684095692, 6179.907301390573, 6189.659568723763, 6091.664958427152, 6190.783322583688, 6221.129041934223, 6253.468455181361, 6261.405166509175, 6057.697115144313, 6079.848003799941, 6080.513558915188, 6085.711159955039, 6116.061877111602, 5928.881422371443, 6030.39696030411, 6052.03167493199, 6108.816735497942, 6120.969395152996, 5924.9927512323875, 5941.643501389931, 5952.791652292149, 5954.583179177416, 6004.069369247599, 6059.3637668045985, 6059.545534084873, 6116.480099191618, 6123.7244324006415, 6142.1266513713745, 5757.050086735641, 5848.853778655568, 5868.002439585366, 5936.28764548257, 5941.732622032106], "unit": "score", "name": "dojo.html", "value": 5682.447151420331}, {"lowerIsBetter": false, "replicates": [445.2719803121895, 575.2981362737459, 576.9758678345938, 631.2172905597058, 649.0718272869796, 26726.866365668167, 39787.40318895215, 40211.597884021154, 40236.0, 40354.78935631936, 42711.0, 43336.0, 43391.0, 43435.78282108585, 43667.78166109173, 9579.233661307078, 9846.163076138537, 9848.113669769718, 9854.507274636275, 9856.310058295921, 8629.439086459392, 9713.660021899235, 9743.658971935984, 9869.753256168617, 9886.357386769872, 9898.653547125852, 9980.051895069957, 9991.000899910023, 10002.299839011272, 10013.299069065168, 9883.50582470877, 9957.751056223653, 9962.103410693, 9970.953049929725, 9978.151857092156, 9634.9518252409, 9651.420914745138, 9705.175060119898, 9864.95067524665, 9900.415933450686, 41861.372079418834, 42217.36673949893, 42267.36598951018, 42322.0, 42521.78739106315, 3271.4765637497885, 3385.2890892912274, 3440.6559344065645, 3491.773034752758, 3779.4708740776314, 29447.0, 29481.70518294811, 30806.075817725505, 30820.845895770603, 30822.691773082206, 2834.7448729614434, 2835.432913417325, 2841.829490230593, 2923.006177899503, 2997.220722612115, 436216.0, 436612.0, 437000.81499592616, 437239.0, 439179.0, 63019.68490157612, 64803.0, 64908.67545662336, 64993.0, 64994.0, 68744.3125568748, 68864.31135688678, 68907.65546172237, 68985.65507172432, 69021.65489172522, 15593.298301576457, 17337.65324693499, 17597.7360339595, 17612.559686007953, 17647.911760441373, 11792.823107653392, 11872.228305160137, 11882.0, 11913.880861191277, 13184.934075329562, 14967.711293769733, 18881.339153129575, 19554.902225489066, 19563.706544401844, 19600.0, 6464.612123272619, 8195.180481951757, 8336.874946875801, 8367.330613550901, 8396.454230475, 949.3734135470694, 981.293468702533, 993.3692105513052, 1012.6152062216458, 1103.2112039891515, 29070.709292907224, 29177.270568235963, 29618.0, 30333.0, 30459.390812184076, 1076.1659713721929, 1124.2299025167786, 1163.9941800291115, 1164.7554013657227, 1184.549871049013, 14998.925005374904, 15281.006734562217, 15398.15310157952, 15526.223688815515, 15536.689266214613, 618734.0, 630072.0, 633127.0, 635393.0, 637417.0, 62431.0, 62932.0, 62985.68507157435, 63025.68487157627, 63286.68356658187, 1332.9866701333056, 1445.985540144585, 1499.6250937265684, 1500.6398464368692, 1504.4207979927808, 25631.487370252864, 26620.866895665396, 29691.96078137255, 30361.24096897595, 30781.538276926312, 42407.0, 49013.0, 49308.520744377725, 49335.75332123316, 49391.753041234566, 388769.0, 389090.0, 390038.0, 390325.0, 601129.0, 33700.49449258312, 34756.47865281972, 34799.826000869834, 34802.477962830075, 34820.65179348174, 47336.526634733214, 48574.27138592995, 48650.756746217456, 48758.0, 49155.754221228664, 36610.8169459151, 36632.0, 36839.63160368469, 37353.0, 37618.623813761515, 35319.29361412809, 37255.627443725214, 37428.0, 37827.810860945516, 38376.42435363416, 37396.81301593475, 37491.2501749958, 37735.433968491045, 37819.865404037926, 37958.0, 32637.836810815796, 33750.83124584361, 33786.0, 33787.0, 33831.830840846626, 21035.579288414454, 23464.296071117893, 25170.74829251684, 25356.619650705623, 25428.474291542567], "unit": "score", "name": "ext.html", "value": 20101.05735781752}, {"lowerIsBetter": false, "replicates": [364.08251206958465, 367.3938002296211, 373.16597404800285, 373.4435690820678, 378.2831534242609, 19747.1113799879, 20424.89787551062, 21317.57364852704, 21507.03218355174, 21834.672479912813, 20720.171193152255, 21005.579888402222, 21505.56988860226, 21624.0, 21646.458838529044, 5679.545636349082, 5834.27071616048, 5883.529317654598, 5884.235049443566, 5887.058070708687, 5673.26247587815, 5755.510781583549, 5846.064629659255, 5849.0, 5874.0014197586515, 5766.106253530709, 5789.073748200289, 5799.159121927339, 5804.2744656917885, 5804.419558044204, 5635.718214089299, 5676.176954341618, 5762.1068734346245, 5802.854928626776, 5811.215485909391, 4419.806652203887, 4818.59041981432, 5007.4491805901325, 5026.673266237683, 5039.924401133986, 25671.74328256712, 25876.094336698126, 26214.86892565544, 26277.868610657017, 26320.473590528272, 2125.9255926042515, 2354.2701762453694, 2377.5601513720017, 2505.1232068775967, 2511.2466260122073, 12898.677533061655, 14096.154230746188, 14612.926935365254, 15414.426245756578, 15553.988990715681, 1728.858953090954, 1812.7190285505767, 1858.1452531835373, 1871.709884967832, 1934.3906669399094, 102801.0, 105401.47299263532, 106838.46580767124, 107376.0, 109466.0, 10452.007059329351, 10570.418626975435, 10736.174850275473, 10927.235093543535, 11043.0, 13172.341382930816, 13258.933705331412, 13307.135036222615, 13307.467701292033, 13380.531681391105, 8654.740357789276, 8838.425502342327, 8843.425177363451, 8951.776205594782, 8982.191602755784, 9073.81852362949, 9087.772805679779, 9118.726438206864, 9133.269338452908, 9302.348835581444, 5269.050451333032, 6420.74317027323, 6420.775272865428, 6424.486041116699, 6440.194975628046, 1819.4450692538903, 1822.7630408046869, 1824.9543761405805, 1827.835494805474, 1862.7299041638887, 959.0792838874619, 965.8937516873139, 978.5645387802359, 1072.4634794817964, 1096.6326280696055, 20683.965801709855, 20689.0, 21169.047392867356, 21423.46441338948, 21488.42138943337, 906.6464079009191, 937.9307589348149, 999.7050869993369, 1024.4928760263717, 1033.9172866170688, 9692.75768105803, 11436.771264574661, 11794.053981093024, 11830.231034982871, 11858.525658973544, 651067.0, 655485.0, 658223.0, 663665.0, 666253.0, 72674.63662681653, 102207.0, 125655.3717231408, 131721.0, 136625.0267613985, 1016.694991502561, 1045.7542477517777, 1062.2776511971933, 1063.6224140430036, 1064.7178497698117, 18641.44075677732, 18906.43280701581, 18976.62046759085, 19087.0, 19101.235950561822, 53934.46065539451, 53954.0, 54234.101806436585, 54813.725931371686, 55022.44977550173, 76995.61502192453, 79719.60140199494, 80392.59803700945, 80700.0, 81271.18728812873, 7806.804829879071, 7970.242826931432, 7988.760337189894, 8146.714864979697, 8365.0, 12880.742385152433, 13107.672308192372, 13210.075294729277, 13435.0, 13450.596482105553, 11364.090872729996, 11430.14273929442, 11516.193866429605, 11633.825492617787, 11801.29192248468, 9051.683191088281, 10489.007088653132, 11246.718832029264, 11523.078153747512, 11756.23584467007, 10347.94826025865, 11408.087353011904, 11476.311421314414, 11702.35637039971, 11977.461014254553, 8051.35589152878, 8089.393295502743, 8123.634436450492, 8187.385946054189, 8402.579871006548, 10967.561297548009, 11580.30518168879, 11864.881351186377, 11891.405429728306, 11934.462949167135], "unit": "score", "name": "jquery.html", "value": 9790.486310453563}, {"lowerIsBetter": false, "replicates": [1438.3671184678747, 1565.608597850537, 1594.0515393340959, 1884.7455593494874, 2026.9493262668423, 8052.758417247477, 8690.435121717092, 8849.29205663547, 8867.334949878768, 8880.156385143417, 8463.28062114721, 8733.825323493526, 8738.38831281809, 8746.781330466725, 8748.0, 2185.4317877351923, 2437.500312435955, 2464.236086813089, 2490.987545062272, 2492.0654754467073, 2504.8371855829405, 2517.748225177486, 2519.924402267935, 2522.117258959368, 2522.9116980905674, 2428.611422172453, 2478.7149477810012, 2499.687539057618, 2504.248725382387, 2509.2848538166627, 2450.5956517174645, 2482.888270027853, 2496.6005439129835, 2499.650048993133, 2500.549901017834, 2097.2554743066144, 2439.48770758141, 2449.6937882764655, 2465.987670061656, 2500.4124030852736, 8832.381733278673, 8913.1086891311, 8914.821703565956, 8923.10768923109, 8952.373333866632, 5406.648567843077, 5519.613627046108, 5564.221009058735, 5566.109422492382, 5576.33084029915, 3543.167355671415, 3640.1263696712863, 3704.4258139988347, 3708.480812686199, 3716.2939041582285, 1018.9337693049928, 1041.3075304922218, 1048.6801525534709, 1051.5898799468214, 1059.8569193158903, 12104.697382565419, 12152.696182595417, 12155.209911355734, 12161.270323780689, 12169.452374643162, 4758.724327934593, 4811.0, 4817.566419022305, 4846.854594362104, 4860.416749990024, 10195.235357348229, 10202.234832387452, 10212.0, 10217.386956782617, 10238.12975897057, 5423.403425623178, 5440.3743569489225, 5441.183822426668, 5441.483059109379, 5448.291722076105, 4493.505714371417, 4630.884227894262, 4848.466668666444, 4986.177280748709, 4993.850184494471, 3395.762296639261, 3919.9020024499046, 3998.080441498472, 4004.539477960072, 4036.354183330653, 1321.914075585084, 1343.8320209973754, 1352.6734017489903, 1355.8034085057611, 1359.463012110211, 1192.9582464613698, 1195.748892732536, 1267.2206592945272, 1299.246437066499, 1383.3221721356665, 6977.651117444209, 7962.800929976681, 8122.7157049502985, 8139.83720325602, 8193.79515512117, 521.8173639226317, 530.1649901405225, 538.504575790266, 541.5613353183934, 545.2393910494917, 6104.755809767648, 6126.785562505291, 6188.133661287423, 6204.720787564571, 6221.3156552779155, 10298.382097074049, 10637.627683031056, 10641.627543035956, 10722.249442538947, 10738.194635402377, 9910.405375677483, 10205.948970255102, 10515.84226236607, 10523.894761052292, 10585.0, 8215.548144851971, 8286.378521610903, 8328.916710832935, 8329.125441828643, 8346.749597511964, 6572.901406478811, 7734.381249499914, 7810.336121429742, 7859.0, 7902.762917112495, 9278.72163835086, 9285.72142835716, 9335.06649335061, 9457.0, 9523.0, 9447.24422046221, 9682.70951871445, 9708.077732615391, 9956.153726933002, 9964.750881228027, 6764.932350676627, 6960.756373526902, 7147.356737893615, 7546.622668866425, 7604.50570712924, 8171.978502687164, 8172.6730930762105, 8207.9589602054, 8224.465409748347, 8225.136360682282, 6637.867242655217, 7062.39969602569, 7211.4230861532005, 7323.12122545298, 7437.739679111205, 7120.893186602309, 7220.711171553289, 7268.0914885639295, 7303.233160518069, 7353.7058517660835, 6911.17065952089, 7590.316871481593, 7723.459357844897, 7727.265909738566, 7742.444993152359, 5558.499735023867, 7010.544314619533, 7012.228654848064, 7014.649267536704, 7035.964820175866, 6980.127484064492, 7104.644767761694, 7114.50198486101, 7126.251743566851, 7128.607926564089], "unit": "score", "name": "mootools.html", "value": 4825.061845053156}, {"lowerIsBetter": false, "replicates": [327.24733113838175, 329.7526854858854, 334.9145967778216, 335.3962866839688, 342.59915898398873, 6423.614583125016, 6489.1888513935755, 6498.740050397979, 6507.967460162693, 6526.28210896801, 6396.776112836052, 6399.072134540489, 6458.160439142905, 6481.481481481482, 6509.576877502959, 4641.8839529011875, 4704.717716936994, 4761.166795810736, 4869.951300486994, 4879.853604391874, 4817.084753896748, 4829.034193161364, 4836.854894353175, 4856.514348565133, 4867.196912509432, 4795.808167673306, 4807.951920480803, 4817.253325734517, 4818.518148185189, 4826.831060912868, 4576.427946506687, 4614.792334344946, 4701.835435759732, 4745.1695953208055, 4746.240601503743, 4053.8175782089875, 4071.0, 4078.9592104078874, 4085.775282359469, 4091.3453847384276, 6174.104754810573, 6193.969030154865, 6197.504199664016, 6201.81394558164, 6232.34560371159, 5592.4407559244155, 5595.8808238352085, 5599.300087489064, 5607.551395888319, 5627.5779316551425, 6838.931610683929, 6840.008198811194, 6849.589024658487, 6853.314668533157, 6853.9314606853795, 4318.4170137031415, 4476.082403107388, 4511.819527218908, 4531.52418996004, 4544.454665440168, 7162.964185179093, 7292.088488938883, 7307.561546307238, 7307.561546307238, 7312.8171795705, 4586.518415566385, 4589.265717485253, 4592.288195329663, 4592.586667199901, 4597.95402045982, 4639.675222734444, 4640.396748422683, 4641.651876109306, 4644.907101858012, 4652.860414187579, 5487.64330318528, 5501.339839219239, 5510.448955104457, 5518.448155184449, 5518.696471694015, 6638.6390789887955, 6915.827104322331, 6954.061201737701, 6986.056882320923, 6986.336298051677, 1592.4983630156464, 1607.3490236454254, 1617.7249867522548, 1618.8623966962705, 1621.5946013496625, 971.455984648599, 1008.4251976373397, 1026.779242462874, 1035.471909326249, 1058.063613701864, 6433.099366088752, 6537.705803238866, 6550.2794692583775, 6589.439897608757, 6617.205935287796, 7238.746643867439, 7241.710331586678, 7248.202697703248, 7255.129384473897, 7256.4557658175845, 6563.638999855054, 6566.6388348641285, 6579.572327798678, 6581.04574836646, 6581.440577550866, 3295.7692961492944, 3775.414810704345, 3819.2743378757946, 3828.693704503633, 3828.789416582115, 6240.937590624127, 7228.855422891513, 7398.149212840593, 7607.543547387175, 7658.157602663702, 7429.962850185714, 7462.552246865205, 7481.812954676177, 7486.176520582731, 7519.8496030079095, 6088.51291896656, 7592.354649854824, 7602.733904313433, 7607.505512141804, 7618.352440042548, 5832.912506312494, 5834.591578589458, 5914.260717410324, 7010.299237905131, 7253.782386528413, 6975.651217439209, 7118.181409138016, 7126.679299431642, 7158.785236442915, 7177.425805935617, 7529.171791103084, 7592.696292148473, 7595.240475952361, 7596.772096837104, 7608.087029556488, 4547.454305483363, 4609.216433206296, 4609.492955774929, 4610.124076425468, 4618.491965883817, 7174.713011479483, 7184.389326907062, 7190.784276471714, 7192.388646965067, 7200.0, 5617.382087970402, 6672.766453174309, 6966.1988871280455, 6992.510524263253, 6993.580385176702, 6920.204176519564, 6951.20061192949, 6957.478189135936, 6964.199117101598, 6977.441804655717, 6784.457243420613, 6800.353966373186, 6801.829954251183, 6802.8639427212165, 6808.289482232294, 5650.547956163415, 6682.899756503753, 6938.722451101899, 6945.444364450933, 6948.583085014915, 6610.173728283965, 6778.084958530535, 6908.689108990208, 6911.5853048817235, 6916.239213686591], "unit": "score", "name": "prototype.html", "value": 5061.658642486205}, {"lowerIsBetter": false, "replicates": [716.74197288976, 763.7937756805662, 766.5898744171866, 780.5238804329358, 826.5784449930534, 15187.936844420896, 15305.84694153058, 15346.846531534682, 15420.614484637876, 15444.227788610553, 14698.191599462025, 14782.965192436533, 14792.482263120794, 14796.408143674267, 14810.259487025633, 762.8741257692474, 769.2230846844672, 933.2673851026946, 954.2747511890943, 972.7422233108232, 955.5031383680482, 960.7790208252106, 963.2005435488528, 967.2310513142033, 967.9467629280387, 1021.8927012663675, 1025.8820235672881, 1026.0611540440489, 1028.0541901450683, 1028.588564574169, 793.2107552984788, 802.9036515618105, 985.6698006167942, 1013.9543720532594, 1020.5815615597606, 745.4483682075279, 746.3208480282916, 746.5856449670431, 747.3162056718096, 749.4454103963028, 15065.849341506555, 15105.622359441102, 15164.696706065928, 15176.089434633846, 15194.848051519453, 12617.179883307555, 12687.302198379086, 12743.936280318632, 12849.173181899967, 13091.279979601119, 9967.75080622983, 9993.900060999442, 10169.288149829516, 10698.465076746132, 10850.674479765541, 3590.1024743814046, 3657.835397407123, 3676.3750162472443, 3679.816009199529, 3682.0426689061037, 84001.73997390045, 84195.0, 84514.15485845186, 84907.57546212229, 85156.14843851545, 9339.813203735886, 9431.717048488556, 9584.137427631547, 9667.226621870233, 9747.56135973883, 17884.374046908295, 18707.90646046761, 20876.895615521826, 21333.893330533247, 21348.679769803464, 7476.1776204617445, 7562.357199637982, 7634.427417943676, 7654.272844079804, 7914.841703165905, 4063.6139566741113, 4135.91728165435, 4170.520390155171, 4185.162967406531, 4262.893427664271, 3621.909452263662, 3661.2494438640547, 3663.0292972362345, 3667.1198912261398, 3669.101070237809, 610.8747706720112, 638.7572722365471, 659.36700767263, 673.4780545077506, 691.4364792693939, 530.9628326017219, 543.570579242402, 558.8602849287678, 606.5390303369383, 627.6014730646073, 7842.137364889858, 8087.514749115072, 8108.513489190667, 8144.104148543655, 8330.8333833323, 593.1606776411415, 614.241411856357, 621.3320680268729, 621.7699451202993, 635.7743001234587, 3625.4743062255825, 3677.2645470905927, 3769.3215221260434, 4010.598940106024, 4015.377616469452, 94788.57817132749, 96012.51993740126, 96267.51866240765, 97399.0, 99295.0, 80895.0, 81110.37779244382, 81873.18126818775, 82941.0, 83784.0, 70591.64704176446, 71485.64257178681, 71542.56914861778, 71890.0, 72792.54414911671, 7694.884576731465, 7724.845503089794, 7863.606819659109, 7915.406344524068, 8012.0, 48918.75540622274, 49518.76203094952, 49904.75047624738, 50458.0, 51627.70930726762, 63548.68225659027, 68933.0, 69091.65454172697, 69524.6523767378, 70441.29558704347, 9241.412404526744, 9932.404055756677, 10031.097201251923, 11007.83488247693, 11320.490577924178, 12026.338551379407, 12053.63839084829, 12269.466316710412, 12404.0, 12446.25322480654, 11258.7748245033, 11592.884071159518, 11703.063754899758, 11706.707332316419, 12406.069544784357, 11081.612143574936, 11135.777284454103, 11147.386893720923, 11201.38392388394, 11531.942340288246, 11210.66368008961, 11219.495122719334, 11288.717782055513, 11503.256338362697, 11567.652970410902, 9561.760955976157, 9600.951995239979, 9648.614055437703, 9913.603455861974, 9999.400035997864, 9277.109632238202, 9586.376885502421, 9611.567479463301, 9632.181264592587, 9724.27067969891], "unit": "score", "name": "yui.html", "value": 7011.148493786158}], "name": "dromaeo_css", "value": 7592.125848783783}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 106.0, 111.0, 109.0, 112.0, 113.0, 116.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [157.0, 120.0, 143.0, 160.0, 114.0, 141.0, 139.0, 119.0, 160.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 137.0}, {"lowerIsBetter": true, "replicates": [184.0, 182.0, 186.0, 184.0, 185.0, 187.0, 186.0, 186.0, 181.0, 179.0], "unit": "score", "name": "audio-dft", "value": 184.0}, {"lowerIsBetter": true, "replicates": [82.0, 75.0, 87.0, 78.0, 57.0, 60.0, 58.0, 81.0, 76.0, 56.0], "unit": "score", "name": "audio-fft", "value": 71.0}, {"lowerIsBetter": true, "replicates": [95.0, 93.0, 131.0, 81.0, 79.0, 86.0, 110.0, 77.0, 78.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 94.0}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 87.0, 85.0, 88.0, 87.0, 94.0, 84.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.7}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 92.0, 93.0, 106.0, 149.0, 92.0, 93.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 99.9}, {"lowerIsBetter": true, "replicates": [88.0, 88.0, 85.0, 97.0, 141.0, 120.0, 86.0, 87.0, 83.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 53.0, 54.0, 53.0, 55.0, 64.0, 56.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [65.0, 73.0, 70.0, 74.0, 71.0, 68.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 82.0, 82.0, 82.0, 81.0, 82.0, 81.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [120.0, 121.0, 128.0, 131.0, 125.0, 130.0, 130.0, 130.0, 118.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [131.0, 123.0, 140.0, 137.0, 137.0, 128.0, 138.0, 144.0, 172.0, 178.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 70.0, 82.0, 96.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.7}], "name": "kraken", "value": 1427.2000000000003}]} 17:30:37 INFO - Return code: 0 17:30:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:30:37 ERROR - # TBPL SUCCESS # 17:30:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:30:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:30:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:30:37 INFO - 2016-03-10 17:30:37.351 screenresolution[1945:15431] starting screenresolution argv=screenresolution get 17:30:37 INFO - 2016-03-10 17:30:37.354 screenresolution[1945:15431] Display 0: 1600x1200x32@60 17:30:37 INFO - 2016-03-10 17:30:37.359 screenresolution[1946:15434] starting screenresolution argv=screenresolution list 17:30:37 INFO - Available Modes on Display 0 17:30:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:30:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:30:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:30:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:30:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:30:37 INFO - Intel Iris: 17:30:37 INFO - Chipset Model: Intel Iris 17:30:37 INFO - Type: GPU 17:30:37 INFO - Bus: Built-In 17:30:37 INFO - VRAM (Dynamic, Max): 1536 MB 17:30:37 INFO - Vendor: Intel (0x8086) 17:30:37 INFO - Device ID: 0x0a2e 17:30:37 INFO - Revision ID: 0x0009 17:30:37 INFO - Displays: 17:30:37 INFO - Display: 17:30:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:30:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:30:37 INFO - Display Serial Number: 1600x1200 60 17:30:37 INFO - Main Display: Yes 17:30:37 INFO - Mirror: Off 17:30:37 INFO - Online: Yes 17:30:37 INFO - Rotation: Supported 17:30:37 INFO - Return code: 0 17:30:37 INFO - Running post-action listener: _resource_record_post_action 17:30:37 INFO - Running post-run listener: _resource_record_post_run 17:30:38 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 2875392; Write bytes: 705063936; Read time: 50; Write time: 1873 17:30:38 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 388827648; Write bytes: 384292352; Read time: 28853; Write time: 703 17:30:38 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 2875392; Write bytes: 299304448; Read time: 50; Write time: 1125 17:30:38 INFO - Running post-run listener: _upload_blobber_files 17:30:38 INFO - Blob upload gear active. 17:30:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:30:38 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 17:30:38 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'] 17:30:38 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 17:30:39 INFO - (blobuploader) - INFO - Open directory for files ... 17:30:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:30:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:39 INFO - (blobuploader) - INFO - Done attempting. 17:30:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:30:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:30:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:40 INFO - (blobuploader) - INFO - Done attempting. 17:30:40 INFO - (blobuploader) - INFO - Iteration through files over. 17:30:40 INFO - Return code: 0 17:30:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:30:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:30:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d207b6ba370c8e07b905a711e29bf4cd81640c38507318716a1e16266d9eca216fb0838fad043772b982c30ad04def4999f78be164d8fd888905d1df3f3b5090", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c16e9b5d2a862b9fe66e44bc7e459f88bde690ca75098619b28896be76e2f34ed8bcf60c28f15cd4224bb8ee06c62cf5846d786b758d39bbfb39d185518d941"} 17:30:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:30:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:30:40 INFO - Contents: 17:30:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d207b6ba370c8e07b905a711e29bf4cd81640c38507318716a1e16266d9eca216fb0838fad043772b982c30ad04def4999f78be164d8fd888905d1df3f3b5090", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c16e9b5d2a862b9fe66e44bc7e459f88bde690ca75098619b28896be76e2f34ed8bcf60c28f15cd4224bb8ee06c62cf5846d786b758d39bbfb39d185518d941"} 17:30:40 INFO - Running post-run listener: copy_logs_to_upload_dir 17:30:40 INFO - Copying logs to upload dir... 17:30:40 INFO - mkdir: /builds/slave/test/build/upload/logs 17:30:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.884791 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-10 17:30:40.965851) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 17:30:40.968909) ========= 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.XVG6759hTi/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.diGlmWJOzu/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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/d207b6ba370c8e07b905a711e29bf4cd81640c38507318716a1e16266d9eca216fb0838fad043772b982c30ad04def4999f78be164d8fd888905d1df3f3b5090", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c16e9b5d2a862b9fe66e44bc7e459f88bde690ca75098619b28896be76e2f34ed8bcf60c28f15cd4224bb8ee06c62cf5846d786b758d39bbfb39d185518d941"} build_url:https://queue.taskcluster.net/v1/task/RlC6xTSwS4itryDWbBHDCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011641 build_url: 'https://queue.taskcluster.net/v1/task/RlC6xTSwS4itryDWbBHDCQ/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/d207b6ba370c8e07b905a711e29bf4cd81640c38507318716a1e16266d9eca216fb0838fad043772b982c30ad04def4999f78be164d8fd888905d1df3f3b5090", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c16e9b5d2a862b9fe66e44bc7e459f88bde690ca75098619b28896be76e2f34ed8bcf60c28f15cd4224bb8ee06c62cf5846d786b758d39bbfb39d185518d941"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 17:30:41.001052) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 17:30:41.001407) ========= 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.XVG6759hTi/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.diGlmWJOzu/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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.004738 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 17:30:41.056567) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 17:30:41.057231) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 17:30:41.057815) ========= ========= Total master_lag: 0.48 =========