builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0189 starttime: 1458951238.79 results: success (0) buildid: 20160325151528 builduid: 5a2db5f15dc141b980b4d2c2128b6ccb revision: d4ccb3062261c79044eb88f7f63d3afd80740979 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:58.792578) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:58.793050) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:58.793345) ========= 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.5AKiIcER0P/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.G8YIzUazPM/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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.005464 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:58.839042) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:58.839351) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:58.888743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:58.889073) ========= 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.5AKiIcER0P/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.G8YIzUazPM/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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.005948 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:58.952932) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:58.953228) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:58.956600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:58.956895) ========= 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.5AKiIcER0P/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.G8YIzUazPM/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-25 17:13:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.6M=0.001s 2016-03-25 17:13:59 (11.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.507473 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:59.493467) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:59.493780) ========= 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.5AKiIcER0P/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.G8YIzUazPM/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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.026985 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:59.560260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:13:59.563647) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d4ccb3062261c79044eb88f7f63d3afd80740979 --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 d4ccb3062261c79044eb88f7f63d3afd80740979 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5AKiIcER0P/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.G8YIzUazPM/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-25 17:13:59,644 truncating revision to first 12 chars 2016-03-25 17:13:59,644 Setting DEBUG logging. 2016-03-25 17:13:59,644 attempt 1/10 2016-03-25 17:13:59,644 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d4ccb3062261?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 17:14:00,299 unpacking tar archive at: fx-team-d4ccb3062261/testing/mozharness/ program finished with exit code 0 elapsedTime=0.892447 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:14:00.480096) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 17:14:00.483465) ========= echo d4ccb3062261c79044eb88f7f63d3afd80740979 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd4ccb3062261c79044eb88f7f63d3afd80740979'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5AKiIcER0P/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.G8YIzUazPM/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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 d4ccb3062261c79044eb88f7f63d3afd80740979 program finished with exit code 0 elapsedTime=0.005600 script_repo_revision: 'd4ccb3062261c79044eb88f7f63d3afd80740979' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 17:14:00.540108) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 17:14:00.540410) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 17:14:00.574561) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-03-25 17:14:00.574850) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5AKiIcER0P/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.G8YIzUazPM/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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:14:00 INFO - MultiFileLogger online at 20160325 17:14:00 in /builds/slave/test 17:14:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:14:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:14:00 INFO - {'append_to_log': False, 17:14:00 INFO - 'base_work_dir': '/builds/slave/test', 17:14:00 INFO - 'blob_upload_branch': 'Fx-Team', 17:14:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:14:00 INFO - 'branch': 'Fx-Team', 17:14:00 INFO - 'buildbot_json_path': 'buildprops.json', 17:14:00 INFO - 'config_files': ('talos/mac_config.py',), 17:14:00 INFO - 'default_actions': ('clobber', 17:14:00 INFO - 'read-buildbot-config', 17:14:00 INFO - 'download-and-extract', 17:14:00 INFO - 'populate-webroot', 17:14:00 INFO - 'create-virtualenv', 17:14:00 INFO - 'install', 17:14:00 INFO - 'run-tests'), 17:14:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:14:00 INFO - 'download_minidump_stackwalk': True, 17:14:00 INFO - 'download_symbols': 'ondemand', 17:14:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:14:00 INFO - 'tooltool.py': '/tools/tooltool.py', 17:14:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:14:00 INFO - '/tools/misc-python/virtualenv.py')}, 17:14:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:14:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:14:00 INFO - 'installer_path': 'installer.exe', 17:14:00 INFO - 'log_level': 'info', 17:14:00 INFO - 'log_name': 'talos', 17:14:00 INFO - 'log_to_console': True, 17:14:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:14:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:14:00 INFO - 'opt_config_files': (), 17:14:00 INFO - 'pip_index': False, 17:14:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:14:00 INFO - 'cmd': ('bash', 17:14:00 INFO - '-c', 17:14:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:14:00 INFO - 'enabled': True, 17:14:00 INFO - 'halt_on_failure': False, 17:14:00 INFO - 'name': 'check_screen_resolution'},), 17:14:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:14:00 INFO - 'cmd': ('bash', 17:14:00 INFO - '-c', 17:14:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:14:00 INFO - 'enabled': True, 17:14:00 INFO - 'halt_on_failure': False, 17:14:00 INFO - 'name': 'check_screen_resolution'},), 17:14:00 INFO - 'run_cmd_checks_enabled': True, 17:14:00 INFO - 'sps_profile': False, 17:14:00 INFO - 'sps_profile_interval': 0, 17:14:00 INFO - 'suite': 'dromaeojs-e10s', 17:14:00 INFO - 'system_bits': '32', 17:14:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:14:00 INFO - 'title': 't-yosemite-r7-0189', 17:14:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:14:00 INFO - 'use_talos_json': True, 17:14:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:14:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:14:00 INFO - 'work_dir': 'build'} 17:14:00 INFO - ##### 17:14:00 INFO - ##### Running clobber step. 17:14:00 INFO - ##### 17:14:00 INFO - Running pre-action listener: _resource_record_pre_action 17:14:00 INFO - Running main action method: clobber 17:14:00 INFO - rmtree: /builds/slave/test/build 17:14:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:14:02 INFO - Running post-action listener: _resource_record_post_action 17:14:02 INFO - ##### 17:14:02 INFO - ##### Running read-buildbot-config step. 17:14:02 INFO - ##### 17:14:02 INFO - Running pre-action listener: _resource_record_pre_action 17:14:02 INFO - Running main action method: read_buildbot_config 17:14:02 INFO - Using buildbot properties: 17:14:02 INFO - { 17:14:02 INFO - "project": "", 17:14:02 INFO - "product": "firefox", 17:14:02 INFO - "script_repo_revision": "production", 17:14:02 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:14:02 INFO - "repository": "", 17:14:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:14:02 INFO - "buildid": "20160325151528", 17:14:02 INFO - "pgo_build": "False", 17:14:02 INFO - "basedir": "/builds/slave/test", 17:14:02 INFO - "buildnumber": 639, 17:14:02 INFO - "slavename": "t-yosemite-r7-0189", 17:14:02 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:14:02 INFO - "platform": "yosemite_r7", 17:14:02 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 17:14:02 INFO - "branch": "fx-team", 17:14:02 INFO - "repo_path": "integration/fx-team", 17:14:02 INFO - "revision": "d4ccb3062261c79044eb88f7f63d3afd80740979", 17:14:02 INFO - "stage_platform": "macosx64", 17:14:02 INFO - "builduid": "5a2db5f15dc141b980b4d2c2128b6ccb", 17:14:02 INFO - "slavebuilddir": "test" 17:14:02 INFO - } 17:14:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 17:14:02 INFO - Running post-action listener: _resource_record_post_action 17:14:02 INFO - ##### 17:14:02 INFO - ##### Running download-and-extract step. 17:14:02 INFO - ##### 17:14:02 INFO - Running pre-action listener: _resource_record_pre_action 17:14:02 INFO - Running main action method: download_and_extract 17:14:02 INFO - mkdir: /builds/slave/test/build/tests 17:14:02 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:14:02 INFO - https://queue.taskcluster.net/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:14:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:14:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:14:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/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:14:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/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:14:03 INFO - Downloaded 1199 bytes. 17:14:03 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:14:03 INFO - Using the following test package requirements: 17:14:03 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:14:03 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:03 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 17:14:03 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:03 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 17:14:03 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:03 INFO - u'jsshell-mac.zip'], 17:14:03 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:03 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 17:14:03 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:14:03 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:03 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 17:14:03 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:03 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 17:14:03 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:03 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 17:14:03 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:03 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 17:14:03 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:14:03 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:14:03 INFO - https://queue.taskcluster.net/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:14:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:14:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:14:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/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:14:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/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:14:05 INFO - Downloaded 17943737 bytes. 17:14:05 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:14:05 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:14:08 INFO - Return code: 0 17:14:08 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:14: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:14:08 INFO - https://queue.taskcluster.net/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:14:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:14:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:14:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/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:14:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/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:14:10 INFO - Downloaded 17943737 bytes. 17:14:10 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:14:10 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:14:13 INFO - Return code: 0 17:14: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:14:13 INFO - https://queue.taskcluster.net/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:14:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:14:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:14:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/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:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/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:14:15 INFO - Downloaded 10847531 bytes. 17:14:15 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:14:15 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:14:15 INFO - Return code: 0 17:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:15 INFO - https://queue.taskcluster.net/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:14:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:14:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:14:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 17:14:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FjWElt47QpaQk_kguGnRrg/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:14:20 INFO - Downloaded 111384264 bytes. 17:14:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:14:20 INFO - mkdir: /builds/slave/test/properties 17:14:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:14:20 INFO - Writing to file /builds/slave/test/properties/build_url 17:14:20 INFO - Contents: 17:14:20 INFO - build_url:https://queue.taskcluster.net/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:14:21 INFO - Running post-action listener: _resource_record_post_action 17:14:21 INFO - Running post-action listener: set_extra_try_arguments 17:14:21 INFO - ##### 17:14:21 INFO - ##### Running populate-webroot step. 17:14:21 INFO - ##### 17:14:21 INFO - Running pre-action listener: _resource_record_pre_action 17:14:21 INFO - Running main action method: populate_webroot 17:14:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:14:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:14:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:14:21 INFO - '--tppagecycles', 17:14:21 INFO - '7'], 17:14:21 INFO - 'tests': ['tsvgm']}}, 17:14:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:14:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:14:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:14:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:14:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:14:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:14:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:14:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:21 INFO - 'talos_options': ['--e10s'], 17:14:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:14:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:21 INFO - 'tests': ['damp', 'tps']}, 17:14:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:21 INFO - 'talos_options': ['--e10s'], 17:14:21 INFO - 'tests': ['damp', 'tps']}, 17:14:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:14:21 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 17:14:21 INFO - 'tests': ['dromaeo_dom']}, 17:14:21 INFO - 'other': {'tests': ['a11yr', 17:14:21 INFO - 'ts_paint', 17:14:21 INFO - 'tpaint', 17:14:21 INFO - 'sessionrestore', 17:14:21 INFO - 'sessionrestore_no_auto_restore', 17:14:21 INFO - 'tabpaint']}, 17:14:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:14:21 INFO - 'tests': ['a11yr', 17:14:21 INFO - 'ts_paint', 17:14:21 INFO - 'tpaint', 17:14:21 INFO - 'sessionrestore', 17:14:21 INFO - 'sessionrestore_no_auto_restore', 17:14:21 INFO - 'tabpaint']}, 17:14:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:14:21 INFO - 'tests': ['a11yr', 17:14:21 INFO - 'ts_paint', 17:14:21 INFO - 'tpaint', 17:14:21 INFO - 'sessionrestore', 17:14:21 INFO - 'sessionrestore_no_auto_restore', 17:14:21 INFO - 'tabpaint']}, 17:14:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:14:21 INFO - 'tests': ['a11yr', 17:14:21 INFO - 'ts_paint', 17:14:21 INFO - 'tpaint', 17:14:21 INFO - 'sessionrestore', 17:14:21 INFO - 'sessionrestore_no_auto_restore', 17:14:21 INFO - 'tabpaint']}, 17:14:21 INFO - 'other_l64': {'tests': ['a11yr', 17:14:21 INFO - 'ts_paint', 17:14:21 INFO - 'tpaint', 17:14:21 INFO - 'sessionrestore', 17:14:21 INFO - 'sessionrestore_no_auto_restore', 17:14:21 INFO - 'tabpaint']}, 17:14:21 INFO - 'other_nol64': {'tests': ['a11yr', 17:14:21 INFO - 'ts_paint', 17:14:21 INFO - 'tpaint', 17:14:21 INFO - 'sessionrestore', 17:14:21 INFO - 'sessionrestore_no_auto_restore', 17:14:21 INFO - 'tabpaint']}, 17:14:21 INFO - 'svgr': {'tests': ['tsvgx', 17:14:21 INFO - 'tsvgr_opacity', 17:14:21 INFO - 'tart', 17:14:21 INFO - 'tscrollx', 17:14:21 INFO - 'cart']}, 17:14:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:14:21 INFO - 'tests': ['tsvgx', 17:14:21 INFO - 'tsvgr_opacity', 17:14:21 INFO - 'tart', 17:14:21 INFO - 'tscrollx', 17:14:21 INFO - 'cart']}, 17:14:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:21 INFO - 'tests': ['tp5o']}, 17:14:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:21 INFO - 'talos_options': ['--e10s'], 17:14:21 INFO - 'tests': ['tp5o']}, 17:14:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:21 INFO - 'talos_options': ['--xperf_path', 17:14:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:14:21 INFO - 'tests': ['tp5n']}, 17:14:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:21 INFO - 'talos_options': ['--e10s', 17:14:21 INFO - '--xperf_path', 17:14:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:14:21 INFO - 'tests': ['tp5n']}}, 17:14:21 INFO - 'talos.zip': {'path': '', 17:14:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:14:21 INFO - Running post-action listener: _resource_record_post_action 17:14:21 INFO - ##### 17:14:21 INFO - ##### Running create-virtualenv step. 17:14:21 INFO - ##### 17:14:21 INFO - Running pre-action listener: _resource_record_pre_action 17:14:21 INFO - Running main action method: create_virtualenv 17:14:21 INFO - Creating virtualenv /builds/slave/test/build/venv 17:14:21 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:14:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:14:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:14:21 INFO - Using real prefix '/tools/python27' 17:14:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:14:22 INFO - Installing distribute.............................................................................................................................................................................................done. 17:14:24 INFO - Installing pip.................done. 17:14:24 INFO - Return code: 0 17:14:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:14:24 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:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:24 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:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:24 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 0x10129ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012ab420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d55860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113ae00>, '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 0x100fa3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101135b20>, '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.5AKiIcER0P/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.G8YIzUazPM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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:14:24 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:14:24 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:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AKiIcER0P/Render', 17:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:24 INFO - 'HOME': '/Users/cltbld', 17:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:24 INFO - 'LOGNAME': 'cltbld', 17:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:24 INFO - 'MOZ_NO_REMOTE': '1', 17:14:24 INFO - 'NO_EM_RESTART': '1', 17:14:24 INFO - 'PAGER': '/bin/cat', 17:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:24 INFO - 'PWD': '/builds/slave/test', 17:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:24 INFO - 'SHELL': '/bin/bash', 17:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8YIzUazPM/Listeners', 17:14:24 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 17:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:24 INFO - 'USER': 'cltbld', 17:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:24 INFO - 'XPC_FLAGS': '0x0', 17:14:24 INFO - 'XPC_SERVICE_NAME': '0', 17:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:25 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:14:25 INFO - Cleaning up... 17:14:25 INFO - Return code: 0 17:14:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10129ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012ab420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d55860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113ae00>, '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 0x100fa3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101135b20>, '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.5AKiIcER0P/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.G8YIzUazPM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:14:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AKiIcER0P/Render', 17:14:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:25 INFO - 'HOME': '/Users/cltbld', 17:14:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:25 INFO - 'LOGNAME': 'cltbld', 17:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:25 INFO - 'MOZ_NO_REMOTE': '1', 17:14:25 INFO - 'NO_EM_RESTART': '1', 17:14:25 INFO - 'PAGER': '/bin/cat', 17:14:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:25 INFO - 'PWD': '/builds/slave/test', 17:14:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:25 INFO - 'SHELL': '/bin/bash', 17:14:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8YIzUazPM/Listeners', 17:14:25 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 17:14:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:25 INFO - 'USER': 'cltbld', 17:14:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:25 INFO - 'XPC_FLAGS': '0x0', 17:14:25 INFO - 'XPC_SERVICE_NAME': '0', 17:14:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:25 INFO - Downloading/unpacking psutil>=0.7.1 17:14: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:14: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:14: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:14: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:14: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:14: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:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:14:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:14:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:14:28 INFO - Installing collected packages: psutil 17:14:28 INFO - Running setup.py install for psutil 17:14:28 INFO - building 'psutil._psutil_osx' extension 17:14:28 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:14:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:14:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:14:29 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:14:29 INFO - building 'psutil._psutil_posix' extension 17:14:29 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:14:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:14:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:14:29 INFO - ^ 17:14:29 INFO - 1 warning generated. 17:14:29 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:14:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:14:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:14:29 INFO - Successfully installed psutil 17:14:29 INFO - Cleaning up... 17:14:29 INFO - Return code: 0 17:14:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10129ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012ab420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d55860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113ae00>, '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 0x100fa3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101135b20>, '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.5AKiIcER0P/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.G8YIzUazPM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:14:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AKiIcER0P/Render', 17:14:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:29 INFO - 'HOME': '/Users/cltbld', 17:14:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:29 INFO - 'LOGNAME': 'cltbld', 17:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:29 INFO - 'MOZ_NO_REMOTE': '1', 17:14:29 INFO - 'NO_EM_RESTART': '1', 17:14:29 INFO - 'PAGER': '/bin/cat', 17:14:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:29 INFO - 'PWD': '/builds/slave/test', 17:14:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:29 INFO - 'SHELL': '/bin/bash', 17:14:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8YIzUazPM/Listeners', 17:14:29 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 17:14:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:29 INFO - 'USER': 'cltbld', 17:14:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:29 INFO - 'XPC_FLAGS': '0x0', 17:14:29 INFO - 'XPC_SERVICE_NAME': '0', 17:14:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:14:30 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:14:30 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:14:30 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:14:30 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:14:30 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:14:30 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:14:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:14:33 INFO - Installing collected packages: mozsystemmonitor 17:14:33 INFO - Running setup.py install for mozsystemmonitor 17:14:33 INFO - Successfully installed mozsystemmonitor 17:14:33 INFO - Cleaning up... 17:14:33 INFO - Return code: 0 17:14:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10129ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012ab420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d55860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113ae00>, '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 0x100fa3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101135b20>, '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.5AKiIcER0P/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.G8YIzUazPM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:14:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AKiIcER0P/Render', 17:14:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:33 INFO - 'HOME': '/Users/cltbld', 17:14:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:33 INFO - 'LOGNAME': 'cltbld', 17:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:33 INFO - 'MOZ_NO_REMOTE': '1', 17:14:33 INFO - 'NO_EM_RESTART': '1', 17:14:33 INFO - 'PAGER': '/bin/cat', 17:14:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:33 INFO - 'PWD': '/builds/slave/test', 17:14:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:33 INFO - 'SHELL': '/bin/bash', 17:14:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8YIzUazPM/Listeners', 17:14:33 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 17:14:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:33 INFO - 'USER': 'cltbld', 17:14:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:33 INFO - 'XPC_FLAGS': '0x0', 17:14:33 INFO - 'XPC_SERVICE_NAME': '0', 17:14:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:33 INFO - Downloading/unpacking blobuploader==1.2.4 17:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:36 INFO - Downloading blobuploader-1.2.4.tar.gz 17:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:14:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:14:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:37 INFO - Downloading docopt-0.6.1.tar.gz 17:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:14:37 INFO - Installing collected packages: blobuploader, requests, docopt 17:14:37 INFO - Running setup.py install for blobuploader 17:14:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:14:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:14:37 INFO - Running setup.py install for requests 17:14:38 INFO - Running setup.py install for docopt 17:14:38 INFO - Successfully installed blobuploader requests docopt 17:14:38 INFO - Cleaning up... 17:14:38 INFO - Return code: 0 17:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10129ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012ab420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d55860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113ae00>, '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 0x100fa3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101135b20>, '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.5AKiIcER0P/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.G8YIzUazPM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:14:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AKiIcER0P/Render', 17:14:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:38 INFO - 'HOME': '/Users/cltbld', 17:14:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:38 INFO - 'LOGNAME': 'cltbld', 17:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:38 INFO - 'MOZ_NO_REMOTE': '1', 17:14:38 INFO - 'NO_EM_RESTART': '1', 17:14:38 INFO - 'PAGER': '/bin/cat', 17:14:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:38 INFO - 'PWD': '/builds/slave/test', 17:14:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:38 INFO - 'SHELL': '/bin/bash', 17:14:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8YIzUazPM/Listeners', 17:14:38 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 17:14:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:38 INFO - 'USER': 'cltbld', 17:14:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:38 INFO - 'XPC_FLAGS': '0x0', 17:14:38 INFO - 'XPC_SERVICE_NAME': '0', 17:14:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:14:38 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-bY3Dsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:14:38 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-gtfbuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:14:38 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-9Mx_Nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:14:38 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-EsoT6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:14:39 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-3Vi000-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:14:39 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-v7AhlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:14:39 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-n9JfYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:14:39 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-rpls_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:14:39 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-qYBEIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:14:39 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-CZNIaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:14:39 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-CV5RAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:14:39 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-hVN8f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:14:39 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-ZU10WR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:14:40 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-5vHhOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:40 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-60d9lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:14:40 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-vTyjk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:14:40 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-9LE302-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:14:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:14:40 INFO - Running setup.py install for manifestparser 17:14:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:14:40 INFO - Running setup.py install for mozcrash 17:14:40 INFO - Running setup.py install for mozdebug 17:14:40 INFO - Running setup.py install for mozdevice 17:14:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:14:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:14:41 INFO - Running setup.py install for mozfile 17:14:41 INFO - Running setup.py install for mozhttpd 17:14:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:14:41 INFO - Running setup.py install for mozinfo 17:14:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:14:41 INFO - Running setup.py install for mozInstall 17:14:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:14:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:14:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:14:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:14:41 INFO - Running setup.py install for mozleak 17:14:41 INFO - Running setup.py install for mozlog 17:14:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:14:41 INFO - Running setup.py install for moznetwork 17:14:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:14:42 INFO - Running setup.py install for mozprocess 17:14:42 INFO - Running setup.py install for mozprofile 17:14:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:14:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:14:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:14:42 INFO - Running setup.py install for mozrunner 17:14:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:14:42 INFO - Running setup.py install for mozscreenshot 17:14:42 INFO - Running setup.py install for moztest 17:14:42 INFO - Running setup.py install for mozversion 17:14:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:14:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:14:43 INFO - Cleaning up... 17:14:43 INFO - Return code: 0 17:14:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14: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:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10129ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012ab420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d55860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113ae00>, '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 0x100fa3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101135b20>, '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.5AKiIcER0P/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.G8YIzUazPM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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:14:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:14:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AKiIcER0P/Render', 17:14:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:43 INFO - 'HOME': '/Users/cltbld', 17:14:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:43 INFO - 'LOGNAME': 'cltbld', 17:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:43 INFO - 'MOZ_NO_REMOTE': '1', 17:14:43 INFO - 'NO_EM_RESTART': '1', 17:14:43 INFO - 'PAGER': '/bin/cat', 17:14:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:43 INFO - 'PWD': '/builds/slave/test', 17:14:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:43 INFO - 'SHELL': '/bin/bash', 17:14:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8YIzUazPM/Listeners', 17:14:43 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 17:14:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:43 INFO - 'USER': 'cltbld', 17:14:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:43 INFO - 'XPC_FLAGS': '0x0', 17:14:43 INFO - 'XPC_SERVICE_NAME': '0', 17:14:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:14:43 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-64hzDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:14:43 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-ZZsG0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:14:43 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-JwE4qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:14:43 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-AYKvJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:14:43 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-jIK916-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:14:43 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-wEOJql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:14:43 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:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:14:43 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-SRyUwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:14:44 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-yjNN6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:14:44 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-h4SUnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:14:44 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-WwyJP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:14:44 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-pBir_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:14:44 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-QBJXdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:14:44 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-8JGpi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:14:44 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-x4ITyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:44 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-N5ZeRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:14:44 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-QSzXpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:14:45 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-3SrWQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:14:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:47 INFO - Downloading blessings-1.6.tar.gz 17:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:14:47 INFO - Installing collected packages: blessings 17:14:47 INFO - Running setup.py install for blessings 17:14:48 INFO - Successfully installed blessings 17:14:48 INFO - Cleaning up... 17:14:48 INFO - Return code: 0 17:14:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:14:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:14:48 INFO - Reading from file tmpfile_stdout 17:14:48 INFO - Current package versions: 17:14:48 INFO - blessings == 1.6 17:14:48 INFO - blobuploader == 1.2.4 17:14:48 INFO - docopt == 0.6.1 17:14:48 INFO - manifestparser == 1.1 17:14:48 INFO - mozInstall == 1.12 17:14:48 INFO - mozcrash == 0.17 17:14:48 INFO - mozdebug == 0.1 17:14:48 INFO - mozdevice == 0.48 17:14:48 INFO - mozfile == 1.2 17:14:48 INFO - mozhttpd == 0.7 17:14:48 INFO - mozinfo == 0.9 17:14:48 INFO - mozleak == 0.1 17:14:48 INFO - mozlog == 3.1 17:14:48 INFO - moznetwork == 0.27 17:14:48 INFO - mozprocess == 0.22 17:14:48 INFO - mozprofile == 0.28 17:14:48 INFO - mozrunner == 6.11 17:14:48 INFO - mozscreenshot == 0.1 17:14:48 INFO - mozsystemmonitor == 0.0 17:14:48 INFO - moztest == 0.7 17:14:48 INFO - mozversion == 1.4 17:14:48 INFO - psutil == 3.1.1 17:14:48 INFO - requests == 1.2.3 17:14:48 INFO - wsgiref == 0.1.2 17:14:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10129ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012ab420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d55860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113ae00>, '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 0x100fa3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101135b20>, '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.5AKiIcER0P/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.G8YIzUazPM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:14:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AKiIcER0P/Render', 17:14:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:48 INFO - 'HOME': '/Users/cltbld', 17:14:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:48 INFO - 'LOGNAME': 'cltbld', 17:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:48 INFO - 'MOZ_NO_REMOTE': '1', 17:14:48 INFO - 'NO_EM_RESTART': '1', 17:14:48 INFO - 'PAGER': '/bin/cat', 17:14:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:48 INFO - 'PWD': '/builds/slave/test', 17:14:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:48 INFO - 'SHELL': '/bin/bash', 17:14:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8YIzUazPM/Listeners', 17:14:48 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 17:14:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:48 INFO - 'USER': 'cltbld', 17:14:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:48 INFO - 'XPC_FLAGS': '0x0', 17:14:48 INFO - 'XPC_SERVICE_NAME': '0', 17:14:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:14:48 INFO - Cleaning up... 17:14:48 INFO - Return code: 0 17:14:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10129ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012ab420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d55860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113ae00>, '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 0x100fa3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101135b20>, '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.5AKiIcER0P/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.G8YIzUazPM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:14:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AKiIcER0P/Render', 17:14:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:48 INFO - 'HOME': '/Users/cltbld', 17:14:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:48 INFO - 'LOGNAME': 'cltbld', 17:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:48 INFO - 'MOZ_NO_REMOTE': '1', 17:14:48 INFO - 'NO_EM_RESTART': '1', 17:14:48 INFO - 'PAGER': '/bin/cat', 17:14:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:48 INFO - 'PWD': '/builds/slave/test', 17:14:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:48 INFO - 'SHELL': '/bin/bash', 17:14:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8YIzUazPM/Listeners', 17:14:48 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 17:14:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:48 INFO - 'USER': 'cltbld', 17:14:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:48 INFO - 'XPC_FLAGS': '0x0', 17:14:48 INFO - 'XPC_SERVICE_NAME': '0', 17:14:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:48 INFO - Downloading/unpacking jsonschema 17:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:14:52 INFO - Downloading/unpacking functools32 (from jsonschema) 17:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:52 INFO - Downloading functools32-3.2.3-2.tar.gz 17:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:14:52 INFO - warning: no files found matching '*.txt' 17:14:52 INFO - no previously-included directories found matching 'build' 17:14:52 INFO - no previously-included directories found matching 'dist' 17:14:52 INFO - no previously-included directories found matching '.git*' 17:14:52 INFO - Installing collected packages: jsonschema, functools32 17:14:52 INFO - Running setup.py install for functools32 17:14:52 INFO - warning: no files found matching '*.txt' 17:14:52 INFO - no previously-included directories found matching 'build' 17:14:52 INFO - no previously-included directories found matching 'dist' 17:14:52 INFO - no previously-included directories found matching '.git*' 17:14:52 INFO - Successfully installed jsonschema functools32 17:14:52 INFO - Cleaning up... 17:14:52 INFO - Return code: 0 17:14:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:14: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:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:52 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 0x10129ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012ab420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d55860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113ae00>, '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 0x100fa3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101135b20>, '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.5AKiIcER0P/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.G8YIzUazPM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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:14:52 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:14:52 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:14:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AKiIcER0P/Render', 17:14:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:52 INFO - 'HOME': '/Users/cltbld', 17:14:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:52 INFO - 'LOGNAME': 'cltbld', 17:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:52 INFO - 'MOZ_NO_REMOTE': '1', 17:14:52 INFO - 'NO_EM_RESTART': '1', 17:14:52 INFO - 'PAGER': '/bin/cat', 17:14:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:52 INFO - 'PWD': '/builds/slave/test', 17:14:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:52 INFO - 'SHELL': '/bin/bash', 17:14:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8YIzUazPM/Listeners', 17:14:52 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 17:14:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:52 INFO - 'USER': 'cltbld', 17:14:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:52 INFO - 'XPC_FLAGS': '0x0', 17:14:52 INFO - 'XPC_SERVICE_NAME': '0', 17:14:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:53 INFO - Downloading/unpacking flake8 17:14:53 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:14:53 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:14:53 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:14:53 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:14:53 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:14:53 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:14:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:14:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:14:57 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:14:57 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:14:57 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:14:57 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:14:57 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:14:57 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:14:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:14:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:14:57 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:14:57 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:14:57 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:14:57 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:14:57 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:14:57 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:14:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:14:58 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:14:58 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:14:58 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:14:58 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:14:58 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:14:58 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:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:14:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:14:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:14:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:14:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:14:58 INFO - no previously-included directories found matching 'docs/_build' 17:14:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:14:58 INFO - Running setup.py install for pep8 17:14:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:14:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:14:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:14:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:14:58 INFO - no previously-included directories found matching 'docs/_build' 17:14:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:14:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:14:58 INFO - Cleaning up... 17:14:59 INFO - Return code: 0 17:14:59 INFO - Running post-action listener: _resource_record_post_action 17:14:59 INFO - Running post-action listener: _start_resource_monitoring 17:14:59 INFO - Starting resource monitoring. 17:14:59 INFO - ##### 17:14:59 INFO - ##### Running install step. 17:14:59 INFO - ##### 17:14:59 INFO - Running pre-action listener: _resource_record_pre_action 17:14:59 INFO - Running main action method: install 17:14:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:14:59 INFO - Reading from file tmpfile_stdout 17:14:59 INFO - Detecting whether we're running mozinstall >=1.0... 17:14:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:14:59 INFO - Reading from file tmpfile_stdout 17:14:59 INFO - Output received: 17:14:59 INFO - Usage: mozinstall [options] installer 17:14:59 INFO - Options: 17:14:59 INFO - -h, --help show this help message and exit 17:14:59 INFO - -d DEST, --destination=DEST 17:14:59 INFO - Directory to install application into. [default: 17:14:59 INFO - "/builds/slave/test"] 17:14:59 INFO - --app=APP Application being installed. [default: firefox] 17:14:59 INFO - mkdir: /builds/slave/test/build/application 17:14:59 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:14:59 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:15:33 INFO - Reading from file tmpfile_stdout 17:15:33 INFO - Output received: 17:15:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:15:33 INFO - Running post-action listener: _resource_record_post_action 17:15:33 INFO - ##### 17:15:33 INFO - ##### Running run-tests step. 17:15:33 INFO - ##### 17:15:33 INFO - Running pre-action listener: _resource_record_pre_action 17:15:33 INFO - Running main action method: run_tests 17:15:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:15:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:15:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:15:33 INFO - 2016-03-25 17:15:33.448 screenresolution[1646:7386] starting screenresolution argv=screenresolution get 17:15:33 INFO - 2016-03-25 17:15:33.451 screenresolution[1646:7386] Display 0: 1600x1200x32@60 17:15:33 INFO - 2016-03-25 17:15:33.457 screenresolution[1647:7388] starting screenresolution argv=screenresolution list 17:15:33 INFO - Available Modes on Display 0 17:15:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:15:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:15:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:15:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:15:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:15:33 INFO - Intel Iris: 17:15:33 INFO - Chipset Model: Intel Iris 17:15:33 INFO - Type: GPU 17:15:33 INFO - Bus: Built-In 17:15:33 INFO - VRAM (Dynamic, Max): 1536 MB 17:15:33 INFO - Vendor: Intel (0x8086) 17:15:33 INFO - Device ID: 0x0a2e 17:15:33 INFO - Revision ID: 0x0009 17:15:33 INFO - Displays: 17:15:33 INFO - Display: 17:15:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:15:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:15:33 INFO - Display Serial Number: 1600x1200 60 17:15:33 INFO - Main Display: Yes 17:15:33 INFO - Mirror: Off 17:15:33 INFO - Online: Yes 17:15:33 INFO - Rotation: Supported 17:15:33 INFO - Return code: 0 17:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:15:33 INFO - Python 2.7.3 17:15:33 INFO - Return code: 0 17:15:33 INFO - grabbing minidump binary from tooltool 17:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:33 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 0x10113ae00>, '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 0x100fa3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101135b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:15:33 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:15:33 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:15:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:15:33 INFO - Return code: 0 17:15:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:15:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:15:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:15:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:15:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:15:34 INFO - Return code: 0 17:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0189 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AKiIcER0P/Render', 17:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:15:34 INFO - 'HOME': '/Users/cltbld', 17:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:15:34 INFO - 'LOGNAME': 'cltbld', 17:15:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:15:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:34 INFO - 'MOZ_NO_REMOTE': '1', 17:15:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:15:34 INFO - 'NO_EM_RESTART': '1', 17:15:34 INFO - 'PAGER': '/bin/cat', 17:15:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:34 INFO - 'PWD': '/builds/slave/test', 17:15:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:15:34 INFO - 'SHELL': '/bin/bash', 17:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8YIzUazPM/Listeners', 17:15:34 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 17:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:15:34 INFO - 'USER': 'cltbld', 17:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:34 INFO - 'XPC_FLAGS': '0x0', 17:15:34 INFO - 'XPC_SERVICE_NAME': '0', 17:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:15:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:15:35 INFO - mozversion application_buildid: 20160325151528 17:15:35 INFO - mozversion application_changeset: d4ccb3062261c79044eb88f7f63d3afd80740979 17:15:35 INFO - mozversion application_display_name: Nightly 17:15:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:15:35 INFO - mozversion application_name: Firefox 17:15:35 INFO - mozversion application_remotingname: firefox 17:15:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:15:35 INFO - mozversion application_vendor: Mozilla 17:15:35 INFO - mozversion application_version: 48.0a1 17:15:35 INFO - mozversion platform_buildid: 20160325151528 17:15:35 INFO - mozversion platform_changeset: d4ccb3062261c79044eb88f7f63d3afd80740979 17:15:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:15:35 INFO - mozversion platform_version: 48.0a1 17:15:35 INFO - using testdate: 1458951335 17:15:35 INFO - actual date: 1458951335 17:15:35 INFO - starting webserver on 'localhost:49270' 17:15:35 INFO - SUITE-START | Running 2 tests 17:15:35 INFO - TEST-START | dromaeo_css 17:15:35 INFO - operating with platform_type : mac_ 17:15:35 INFO - Initialising browser for dromaeo_css test... 17:15:35 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/tmpNSwmTP/profile http://localhost:49270/getInfo.html) 17:15:37 INFO - PROCESS | 1665 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:15:38 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 17:15:38 INFO - PROCESS | 1665 | colorDepth:24 17:15:38 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 17:15:38 INFO - PROCESS | 1665 | __metrics 17:15:38 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 17:15:38 INFO - TEST-INFO | 1665: exit 0 17:15:38 INFO - Browser initialized. 17:15:38 INFO - Running cycle 1/1 for dromaeo_css test... 17:15:38 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/tmpNSwmTP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:50 INFO - PROCESS | 1669 | RSS: Main: 254513152 17:15:50 INFO - PROCESS | 1669 | 17:16:40 INFO - PROCESS | 1669 | 1458951400425 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:18:51 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 17:18:53 INFO - PROCESS | 1669 | RSS: Main: 266895360 17:18:53 INFO - PROCESS | 1669 | 17:21:55 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 17:21:55 INFO - PROCESS | 1669 | RSS: Main: 278716416 17:21:55 INFO - PROCESS | 1669 | 17:24:57 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 17:24:58 INFO - PROCESS | 1669 | RSS: Main: 280727552 17:24:58 INFO - PROCESS | 1669 | 17:27:59 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 17:28:00 INFO - PROCESS | 1669 | RSS: Main: 282296320 17:28:00 INFO - PROCESS | 1669 | 17:31:03 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 17:31:03 INFO - PROCESS | 1669 | RSS: Main: 285102080 17:31:03 INFO - PROCESS | 1669 | 17:34:05 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 17:34:06 INFO - PROCESS | 1669 | RSS: Main: 286142464 17:34:06 INFO - PROCESS | 1669 | 17:34:06 INFO - PROCESS | 1669 | __start_tp_report 17:34:06 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 17:34:06 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 17:34:06 INFO - PROCESS | 1669 | |i|pagename|runs| 17:34:06 INFO - PROCESS | 1669 | |0;dojo.html;2899.4780939430893;3521.2429327694545;3521.806300653464;3528.9294214115716;3606.873759418421;4542.795574199161;5861.296644402667;5878.265216847894;5881.735321910513;5951.1668366428685;4829.444613869406;5764.942350576493;5855.092460668592;5968.40315968403;5977.671228082454;5243.79024839006;5309.62832601718;5354.491323324278;5364.812231571896;5402.756875940592;5274.367075950891;5443.129099344106;5454.509094181523;5475.6440831345835;5490.066688662937;5208.088584497736;5281.102212623863;5308.336457942757;5340.439253878345;5344.118220493614;5331.653442526263;5345.251664766935;5348.973255133699;5350.117230656937;5359.249705041298;5236.293100431431;5306.495882891119;5314.681119132826;5333.57331413486;5386;4324.567543245682;5440.483154100354;5743.5118014968775;5791.247137872049;5800.970995144998;5710.628809127435;6257.78097766576;6282.560220784547;6284.497240220817;6303.779367722108;6229.750809967596;6305.833420817117;6312.684365781738;6313.747450101991;6326.114343991845;5792.507636850831;5906.291245050621;5959.970200148971;5986.850328741816;6012.669303188279;6374.330695277022;6408.455281301049;6431.389018043278;6433.035044743232;6450.032495125769;5427.7244847460815;6273.341299163613;6284.402981716729;6290.622562646256;6304.464120549713;6229.7508099676415;6268.561200715997;6296.653684047421;6325.493960483151;6327.335629758901;6132.4778862607845;6231.906521402183;6241.563090583615;6326.177596912464;6355.142055822497;4714.976425117852;5192.9740351298005;5326.6005049621435;6279.120923070774;6327.683615819191;4297.269464191032;4793.448753393334;4907.87730306738;4928.802847886116;4995.300657907896;4422.159789639958;4474.619657329098;4476.395686582335;4480.39514665516;4502.594766471033;5966.254218222723;5983.700814959235;5983.880322393527;6000;6010.128531362928;6111.40942266768;6219.689015549295;6269.811905642747;6288.434040936246;6312.147860038836;5958.344582095966;5994;6000.669963151981;6012.518998480111;6049.395060494004;5473.0969390050195;5474.479924407175;5476.67139971603;5480.150576660624;5492.642978206483;6290.150829637941;6398.968005159944;6447.387498187759;6469.838254043687;6476.255230648536;6248.094026366242;6261;6285.717142728497;6291.1192433058495;6295;6290.899092658675;6399.360063993563;6455.322191169859;6460.67696615158;6468.579542329733;6249.906251406142;6292.27638821523;6299.559030867796;6338.841528961812;6343.9682801585695;5220.895582088413;6046.637201767908;6249.218847644044;6278.937210628018;6299.842503937438;6078.787242446493;6146.494108943338;6191.950464396292;6273.404026617464;6281.277653069956;6030.396960303934;6136.3965394158;6175.475084617858;6185.536084793748;6240.500759939103;5964.463198312173;6082.756689732361;6096.664683442275;6118.785842495491;6149.877002460015;6230.190075290183;6246.531510136849;6284.685765711788;6299.716512757029;6321.367863213642;5986.610870293417;6080.331163571915;6108.0688921796145;6136.417040381157;6154.692265386623 17:34:06 INFO - PROCESS | 1669 | |1;ext.html;461.5453778028642;512.7487531109755;544.5697898660056;563.5632384901701;598.9010166344757;37933;38619.613803861954;38739.644112456066;38742.80628596853;38801.89584833213;39058.80470597643;39506;39587.812365629004;39653;39683.007924801896;9372.671956481525;9526.523673816317;9627.566759495805;9632.662856800014;9643.662471813488;9444;9592.568334424932;9659.90340096597;9718.271129665303;9742.733444652185;9619.519024048805;9635.373700709466;9654.082862128087;9687.612495500172;9769.02309769021;9626.229901607889;9670.56482458291;9686.854697179548;9737.415755054684;9745.707628771077;9530.904690953072;9559.044095590454;9577.616895324249;9600.42397456148;9717.56270967808;38577.807110964546;38676;38855;39131;39188.21623567513;3412.3516531859113;3500.3699334119847;3680.355937710917;3783.959411161925;4150;28856.134315970554;29143.854280728672;29300.827966881297;29327.560086598718;29692.406151876843;2760.9585856212175;2771.7782577393964;2796.258991367289;2797.8740956656998;2867.311845157147;489802;493640;494653.52673236764;496352;497052;45375.77312113418;65061;65418.36454088591;65579.67210163918;65601.34398656047;46368.768156159;46553;47284.52715472801;47604;47753.522464775604;16077.758833617505;16291.348346066261;16294.185290735415;16314.83685163157;16350.264238109314;12673.746525069448;13049;13133.737325253442;13145.145565538209;13167;11984.700382490508;12013.579524716593;14813.777793333109;14945;15090.849091508944;5156.097682905476;6259.561830671809;6304.873902521924;6312.274088479791;6319.9368006320265;762.7177944160696;824.8020475086056;921.8018126102786;977.2231076294363;982.2387649571497;29494;29575.816967321065;29730.702692973227;29990.85004574963;30204.09387718372;1012.4583347908833;1024.8419286206538;1076.7092884921028;1078.9514471848786;1109.9500522476508;14791.334389952477;14867.405303787944;14890.776638350433;15248.771268430983;15259.694806104038;514560;523262;526722;527168;528291;58684;58838.705806470694;59031;59526.404735952085;59556.70221648864;1409.457358916804;1415.9362828672733;1467.8091848059898;1470.4265336518765;1472.5508719840552;26817.731822681522;28727;28947.421051579273;29441.411171776872;29625.40749184961;50328;51564.22653660123;51867.703307417614;51898.481015190875;51960.74019629878;483571;484690;486973;487664;489604;31676.841615791775;31784.36431271408;31948.520772188902;32628.184295392806;33293.50059749154;44000.779996099816;44523.55476445194;45191.77404112958;45411.318830216915;45478.77260613676;34304.656953430145;37440;37607.811960940024;38542.42186367151;38582.2283554333;33521.16197095092;36801.26397472089;36975.07562310964;36981.445278321386;37696;30287.848560757055;31616.051518454482;36819.89540313795;37062.44406333961;37161.4425783608;28244.85877570599;28256.29359266035;28768.705408257098;30937.381252375275;31102.222444438165;23776.64335034941;24562.140325088538;24675.506489869742;25001.624975625746;25005.87497062576 17:34:06 INFO - PROCESS | 1669 | |2;jquery.html;361.1476914481824;364.58073215801824;364.9124210189555;372.7409450431949;379.1544854973411;19131.13033045044;19494.90252548737;20125.295614653507;20621.484462888435;20660.586788264263;11817.172797904128;11897.464614092365;12277.386130693452;12285.324307163124;12319.384030798446;5183.17069268917;5304.20436934459;5430.0768869292315;6127.4791642710425;6131.448169664729;5885.8822823543505;5956.017257152586;5972.283326000865;5995.910061349084;6022.367651396606;5980.222571065756;6045.848853778669;6582.374674405948;6595.53831231814;6621.205455345341;6501.739930402779;6511.641859697715;6558.442532384753;6574.572652777578;6585.176852893388;4998.525434996648;5066.746662666888;5259.2899958505495;5284.625997240707;5382.327209098863;11039.668809935714;11551.249168804;18865.056747162726;23812.40468988272;24591.893364798627;2062.3091264426434;2134.253011445997;2251.864888106719;2259.5819773341987;2744.862756862149;9641.27690423221;9692.90307096927;10191.745206369826;10195.286329956905;10263.538140783683;1459.7956286119952;1715.7254839225664;1750.4573582189435;1762.171779263744;1771.3977247735702;101302;107415;109302;119564;134047;15275.61810954735;18390.448286551426;18927.337543185924;18963.525911852314;19050.237990480226;28566.714332856405;29018.854905725337;29070.12789616315;29837.552436713468;29957.700422995928;10319.535620897077;10404.531796069195;10594.894051059391;10848.566057357775;10899.400532970603;9286.396384235004;9306.953465232766;9336.439813611205;9353.251739860794;9426.915904670914;7724.725420305586;8087.312578430781;8666.739997800076;8717.215450609476;8795.824083518293;3182.363527294504;3456.3605732939486;3470.392681280766;3667.303212389691;3695.815209239527;872.2760109109424;944.4569372610639;1007.7430255284855;1065.6749691344214;1088.455772113943;19193.136308866135;19689.01554922248;19868.205271789255;19891.801081988993;20074.79925200729;976.5166242709904;1010.5149528226345;1014.573878970834;1018.3126389686931;1048.7745134796055;8993.685221017233;9863.358881672812;10193.133583645325;10890.891091088988;10908.890911090946;592932;628210;630110;645686;651058.4894151093;105655.88688226347;112444.43777781223;116673;118745.4062729698;119614;946.7159852044359;1036.3315661398356;1049.1711547877244;1056.3820165203288;1059.7774467361787;17614.471565853044;17744.733828992317;17905.462836114937;18136.818631813512;18213.81786182121;42305.730828075204;44222.89442763956;46393;48255.55233343005;48421;65834;70994;71064.28935710783;71555.64222178856;71839.28160718326;6616.437602803816;6751.831204219934;7971.362291016821;8063.838723225385;8123.5532045738055;12364.81452778227;12412.937935310265;12451.501939922664;12603.621891343275;12770.68073298175;10861.511231994422;11102.500387482743;11188.832167517656;11219.55121795119;11239.381833999209;10461.843072354073;10574.788504229718;10766.73083172927;10954.014138727553;11088.944555277172;10071;11131;11251.49368278413;11453.942730286295;11471.369074700971;7838.3337416320255;8048.436609437517;8069.515829050276;8078.071021832329;8259.463134896212;11037.558497660004;11058.944705276423;11287.492062857355;11302.604408845651;11334.773304533699 17:34:06 INFO - PROCESS | 1669 | |3;mootools.html;1566.9686606267876;1585.389624994377;1848.5286252005737;1939.9903000485003;1967.5572996075894;8133.227343402382;8831.249343805785;8974.551272436376;9212.861807072892;9215.631374745002;8747.737567872973;8847.380683352168;8889.59996800144;8933.017368089504;8999.14508121729;2494.87525623719;2496.9375765605823;2512.1584269269815;2519.8236123471365;2523.205190365029;2459.5818710819112;2514.421683012908;2520.1683444463283;2550.2731721459386;2550.4389034412397;2479.962800557993;2518.7103483099495;2527.304991127436;2530.6204069389646;2556.399246177147;2506.6114752213434;2519.735427780084;2529.3297276221815;2552;2562.3209849389928;2508.7240403555593;2546.2106746908516;2548.503041906829;2550.4516528946365;2561.6541766861424;9131.634734610607;9134.77163070922;9184.219341355993;9185.081491850828;9186.356955013152;5454.072807622674;5504;5522.420145884705;5552.805651802168;5645.604807663465;3592.1378869071496;3696.1888674549546;3740.2706472237924;3758.32350176968;3766.322062028834;1057.1595581512715;1075.9731006724817;1076.784643071389;1084.788466249074;1085.5006696919427;11972.221805582609;12186.634400967985;12439.315837628927;12443.066769992378;12448.439820208021;4958.330625365529;5026.648134630614;5043.117454445457;5099.3370861787735;5100.69395836251;10511.84232236517;10535.578576856993;10557.419341936267;10560.683179504627;10592;5582.888342233133;5613.550915926716;5714.085746280658;5719.828405147852;5736.282964629421;4163.458750362433;4531.093781243764;5089.134847076006;5097.46476619957;5167.870803229949;3268.950965735516;3310.337932413479;3958.5051868516434;4047.1096358801015;4096.05790668148;1338.8594197609305;1339.8459177194552;1341.3494455189225;1350.5003148834994;1352.8444228913802;985.2512090811035;1142.3945308986251;1172.9882701173049;1325.3638253638114;1437.9568612941628;8431.873521897176;8484.915150848412;8485.575721213914;8545.145485451529;8561.0582835888;518.7302602646678;520.2560338715673;523.4137765702437;524.5384062025394;538.3459097196925;5422.3764267109;6314.842128946813;6373.426391624776;6424.3254458282145;6458.160439142881;8982.371234013557;9226.40028398152;9647.179989700813;10824.18818588609;10983.835242471368;8836.91163088361;9484.430934143835;10726.624568140078;10859.728506787393;11050.115990720724;8489.278411334983;8612;8647.827043459221;8652.134786521297;8662.133786621287;7993.600319984093;8156.143604921398;8179.631916563888;8184.304334131427;8241.464304820167;9611.134997850228;9866.950665246628;9906.75233119149;9978.151857092229;10061.446620435947;9272.907270927204;9502.619895204114;9986.450745209084;10142.442165680959;10480.213983951387;6933.514653974174;7418.221086786026;7674.309312161932;7685.308322251024;7768.805779855549;8285.088640249689;8555.144485551395;8558.657653693783;8573.271271941954;8582.013068496954;6077.878442431038;6404.943184374526;7474.738384156529;7556.206598307099;7715.57564333967;7420.480566360519;7425;7445.590492522963;7463.290987356192;7466.775996720107;7891.289783919475;7958.721444749637;8036.236557527026;8051.074126475296;8076.919230807616;6824.454043676593;6998.6850591724515;7207.099112610924;7258.45561582894;7270.781876543712;7136.286371362822;7201.6399180041835;7260.782176534713;7358.337749602561;7366.926330736624 17:34:06 INFO - PROCESS | 1669 | |4;prototype.html;293.69309072019735;332.09007319943345;334.5216340632894;339.07094560903136;343.5190732973836;6730.192376914771;6755.560888542242;6772.390484856362;6840.144981877265;6896.931030689691;6763.8985415218685;6778.45772338213;6791.558548694331;6815.216250131237;6840.110785597865;4739.31279964405;4785.9521404785855;4902.828401005965;4911.214205727084;5015.974920125394;4870.902581948359;4879.658423910328;4889.511048895118;4898;4901.730404827733;4819.373481447407;4831.806727730886;4839.201531747258;4843.249296359052;4851.466338702758;4842.854714358575;4850.223964165734;4861.295112208745;4868.318435419044;4874.073925954075;4227.393590435646;4233.666395085538;4243.066525364415;4245.15096980602;4247.617714405718;5054.519820617035;6238.9376106238815;6259.561830671855;6410.102585638015;6424.068510066061;5026;5593.216949627055;5792.507636850873;5843.4448727371255;5854.414558544111;5697.287839020122;6393.9680301598655;7092.822679433004;7095.574265544033;7120.750773722895;3403;3772.038130276762;4492.876780804799;4551.249043907785;4571.1771881061395;6035.758569657209;6583.210014798207;7518.699252029912;7550.7734767957045;7574.734884279023;4516.96109894726;4683.953160468352;4743.217369134123;4844.539768721966;4848.7090774553635;3930.292547341506;4059.837606495766;4765.451973023078;4765.618750499952;4771.976140119277;4620.306953956866;5704.486596206361;5763.135529670583;5786.04530252512;5807.5644326675665;5820.767169313265;7270.054892864;7281.381082607932;7281.672324745399;7307.525010874276;1650.1666658337463;1672.3895778040928;1672.690552247838;1675.1456757053747;1678.924448399825;1031.8091153136693;1066.5520481397677;1072.5977758340623;1073.9624113156;1083.1551389915878;6603.273639899608;6639.900401493981;6714.630695311805;6718.49611279156;6722.0253063305545;6608.504362172856;7460.664270107858;7462.067241594801;7467.290607392289;7478.2895624915545;5365.812196573179;6010.188624535719;6112.419320164666;6772.5936443813525;6853.417459515997;3697.186618943828;3995.06116062725;4005.8597949072227;4022.577629348935;4026.778527181033;7998.080220774569;8006.15935326794;8017.959910200529;8018.879716804253;8025.157358477392;6326.557141000178;7606.581638009962;7882.605869706492;7883.881741773878;7889.526628402315;6491.578047426997;7934.801629959182;7993.440459167802;8011.879821802678;8045.798855028554;6809.774240636733;7521;7547.811304717206;7557.886631700419;7586.62066896664;6805.2854450283985;7463.440241981764;7479.439042071757;7482;7488.400927925644;7685.654145563575;7997.880031799644;8021.358291336795;8022.117567067501;8028.076771171156;4706.741129237925;4730.124926888537;4730.526947305242;4741.739204343794;4771.117343291502;7561.508501947355;7575.8106047347055;7580.507267027626;7584.469087163846;7585.734499292498;7236.20401755817;7294.416446684147;7311.4516411268305;7311.488195826454;7325.743598974011;5812.94187058124;7025.367716905503;7270.709171633075;7317;7356.337929586363;7134.250903655042;7140.8214794628475;7150.10623672041;7190.532615379983;7191.3887319578425;7279.017332660235;7298.087739032621;7300.758870991838;7308.196098429275;7354.080739907512;7069.9646501767165;7088;7154.821129471805;7156.141263048259;7176.318249766264 17:34:06 INFO - PROCESS | 1669 | |5;yui.html;615.7438824797416;656.310873582738;689.8137502874224;725.974590889319;750.4934169435631;12167.391630418477;15114.47099351523;15248.69502609947;15342.923285383586;15355.846441535581;13696.794548081787;13964.301784910765;14056;14073.577792666236;14530.418783248684;868.2272777228256;882.386741214856;903.3044555692113;913.6939125393002;917.2707697380598;888.7911340834899;904.1230006893303;904.1275169461468;905.3933864310894;906.7869050773063;923.487464457226;945.9385139965915;953.909378609031;958.515949445529;961.0437614573474;917.9311551633588;918.8392031394479;922.5295099499236;950.1211379473993;956.1824639932862;689.8620275944832;707.9079719636466;717.9030830837822;719.6617589732817;720.8882623193414;14731.631709207248;14808.3336249869;14829.629259268497;14869.256537173207;14883.776743348859;12661.493540258378;12684.42920068599;12721;12759.553415630407;12834.614961551168;9973.401595904268;10066.547005384775;10069.09378155962;10128.493575321278;10453.84319235212;3446.138465383654;3495.405781017233;3500.8249587520777;3542.946855797165;3606.747527673064;79805;81462;81760.59119704422;82445.58777206135;84083.15916840815;9452.8582071269;9488.193503552136;9536.141747242782;9651.758706032266;9667.613295468103;20880.582388352148;20960.895195523924;21354.572908542053;21360.572788544454;21396;7598.734044308423;7617.961910190414;7741;7771.805704857424;7822;4092.4270602115726;4119.320312148462;4123.154753275571;4143.544210136883;4163.666906647461;3000.264935090873;3599.2981368632863;3607.3867442534834;3643.2713457308114;3682.0978860179425;636.5766765101156;637.91069250305;639.2105749399487;649.0880313160018;657.135866335767;532.9387120481117;594.04655527878;608.7230310208845;608.9056196289582;620.7175735040636;7874.960625196837;7965.681372745141;8115.756527304072;8374.706885258987;8376.036755773164;523.0506630465693;559.8306660600164;596.3172167867767;617.5245061302771;648.2221334398646;3621.855125794939;3764.698824094066;3878.864239751595;3959.346707793182;3994.980025099856;92083.53958230166;92844.53577732068;93602.12795744183;93902.53048734849;96866.57833554076;84975.57512212523;85259.57370213109;85378;86549.56725216334;86919;72783.63608182031;73782.26217737861;74258;74636.25363746402;74789.62605187048;7566.394688425023;7822.843543129219;7877.803054923673;7975.202479751978;8081.87877181831;49568.26511072095;51684;52034.69913252199;52332;52676.473235267156;71221;71260.93108603479;71331.64334178295;71796.28203718105;72948.27051729415;9741.756456088371;9809.264305176997;9905.455199964072;9983.92889029961;10101.444420556645;10219.897801021894;10394.22043346737;10727.195460340661;10841.024307812335;10994.010539051524;8218.917810822055;10201.489925503844;10257.662840023502;10298;10355.43045132525;8316.91880055589;10058.34620749649;10190.133838623504;10321.948390258001;10337.483125843528;8252.917470825216;9242.815143697222;9583.856242156513;10116.494175291353;10557.41934193596;7703.730369437043;8467.53428561435;8498.490090594583;8694.91305086941;8789.296856251613;7338;8842.425242359226;9022.86465703028;9354.672586459441;9735.756606084904 17:34:06 INFO - PROCESS | 1669 | __end_tp_report 17:34:06 INFO - PROCESS | 1669 | __start_cc_report 17:34:06 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,372 17:34:06 INFO - PROCESS | 1669 | __end_cc_report 17:34:06 INFO - PROCESS | 1669 | __startTimestamp1458952446178__endTimestamp 17:34:06 INFO - PROCESS | 1669 | 17:34:06 INFO - PROCESS | 1669 | ------- Summary: start ------- 17:34:06 INFO - PROCESS | 1669 | Number of tests: 6 17:34:06 INFO - PROCESS | 1669 | 17:34:06 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5791.11 Median:6030.40 stddev:680.17 (11.3%) stddev-sans-first:643.32 17:34:06 INFO - PROCESS | 1669 | Values: 2899.5 3521.2 3521.8 3528.9 3606.9 4542.8 5861.3 5878.3 5881.7 5951.2 4829.4 5764.9 5855.1 5968.4 5977.7 5243.8 5309.6 5354.5 5364.8 5402.8 5274.4 5443.1 5454.5 5475.6 5490.1 5208.1 5281.1 5308.3 5340.4 5344.1 5331.7 5345.3 5349.0 5350.1 5359.2 5236.3 5306.5 5314.7 5333.6 5386.0 4324.6 5440.5 5743.5 5791.2 5801.0 5710.6 6257.8 6282.6 6284.5 6303.8 6229.8 6305.8 6312.7 6313.7 6326.1 5792.5 5906.3 5960.0 5986.9 6012.7 6374.3 6408.5 6431.4 6433.0 6450.0 5427.7 6273.3 6284.4 6290.6 6304.5 6229.8 6268.6 6296.7 6325.5 6327.3 6132.5 6231.9 6241.6 6326.2 6355.1 4715.0 5193.0 5326.6 6279.1 6327.7 4297.3 4793.4 4907.9 4928.8 4995.3 4422.2 4474.6 4476.4 4480.4 4502.6 5966.3 5983.7 5983.9 6000.0 6010.1 6111.4 6219.7 6269.8 6288.4 6312.1 5958.3 5994.0 6000.7 6012.5 6049.4 5473.1 5474.5 5476.7 5480.2 5492.6 6290.2 6399.0 6447.4 6469.8 6476.3 6248.1 6261.0 6285.7 6291.1 6295.0 6290.9 6399.4 6455.3 6460.7 6468.6 6249.9 6292.3 6299.6 6338.8 6344.0 5220.9 6046.6 6249.2 6278.9 6299.8 6078.8 6146.5 6192.0 6273.4 6281.3 6030.4 6136.4 6175.5 6185.5 6240.5 5964.5 6082.8 6096.7 6118.8 6149.9 6230.2 6246.5 6284.7 6299.7 6321.4 5986.6 6080.3 6108.1 6136.4 6154.7 17:34:06 INFO - PROCESS | 1669 | 17:34:06 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:63638.35 Median:38828.45 stddev:133601.67 (344.1%) stddev-sans-first:133892.25 17:34:06 INFO - PROCESS | 1669 | Values: 461.5 512.7 544.6 563.6 598.9 37933.0 38619.6 38739.6 38742.8 38801.9 39058.8 39506.0 39587.8 39653.0 39683.0 9372.7 9526.5 9627.6 9632.7 9643.7 9444.0 9592.6 9659.9 9718.3 9742.7 9619.5 9635.4 9654.1 9687.6 9769.0 9626.2 9670.6 9686.9 9737.4 9745.7 9530.9 9559.0 9577.6 9600.4 9717.6 38577.8 38676.0 38855.0 39131.0 39188.2 3412.4 3500.4 3680.4 3784.0 4150.0 28856.1 29143.9 29300.8 29327.6 29692.4 2761.0 2771.8 2796.3 2797.9 2867.3 489802.0 493640.0 494653.5 496352.0 497052.0 45375.8 65061.0 65418.4 65579.7 65601.3 46368.8 46553.0 47284.5 47604.0 47753.5 16077.8 16291.3 16294.2 16314.8 16350.3 12673.7 13049.0 13133.7 13145.1 13167.0 11984.7 12013.6 14813.8 14945.0 15090.8 5156.1 6259.6 6304.9 6312.3 6319.9 762.7 824.8 921.8 977.2 982.2 29494.0 29575.8 29730.7 29990.9 30204.1 1012.5 1024.8 1076.7 1079.0 1110.0 14791.3 14867.4 14890.8 15248.8 15259.7 514560.0 523262.0 526722.0 527168.0 528291.0 58684.0 58838.7 59031.0 59526.4 59556.7 1409.5 1415.9 1467.8 1470.4 1472.6 26817.7 28727.0 28947.4 29441.4 29625.4 50328.0 51564.2 51867.7 51898.5 51960.7 483571.0 484690.0 486973.0 487664.0 489604.0 31676.8 31784.4 31948.5 32628.2 33293.5 44000.8 44523.6 45191.8 45411.3 45478.8 34304.7 37440.0 37607.8 38542.4 38582.2 33521.2 36801.3 36975.1 36981.4 37696.0 30287.8 31616.1 36819.9 37062.4 37161.4 28244.9 28256.3 28768.7 30937.4 31102.2 23776.6 24562.1 24675.5 25001.6 25005.9 17:34:06 INFO - PROCESS | 1669 | 17:34:06 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:35313.29 Median:11397.42 stddev:104318.16 (915.3%) stddev-sans-first:104577.78 17:34:06 INFO - PROCESS | 1669 | Values: 361.1 364.6 364.9 372.7 379.2 19131.1 19494.9 20125.3 20621.5 20660.6 11817.2 11897.5 12277.4 12285.3 12319.4 5183.2 5304.2 5430.1 6127.5 6131.4 5885.9 5956.0 5972.3 5995.9 6022.4 5980.2 6045.8 6582.4 6595.5 6621.2 6501.7 6511.6 6558.4 6574.6 6585.2 4998.5 5066.7 5259.3 5284.6 5382.3 11039.7 11551.2 18865.1 23812.4 24591.9 2062.3 2134.3 2251.9 2259.6 2744.9 9641.3 9692.9 10191.7 10195.3 10263.5 1459.8 1715.7 1750.5 1762.2 1771.4 101302.0 107415.0 109302.0 119564.0 134047.0 15275.6 18390.4 18927.3 18963.5 19050.2 28566.7 29018.9 29070.1 29837.6 29957.7 10319.5 10404.5 10594.9 10848.6 10899.4 9286.4 9307.0 9336.4 9353.3 9426.9 7724.7 8087.3 8666.7 8717.2 8795.8 3182.4 3456.4 3470.4 3667.3 3695.8 872.3 944.5 1007.7 1065.7 1088.5 19193.1 19689.0 19868.2 19891.8 20074.8 976.5 1010.5 1014.6 1018.3 1048.8 8993.7 9863.4 10193.1 10890.9 10908.9 592932.0 628210.0 630110.0 645686.0 651058.5 105655.9 112444.4 116673.0 118745.4 119614.0 946.7 1036.3 1049.2 1056.4 1059.8 17614.5 17744.7 17905.5 18136.8 18213.8 42305.7 44222.9 46393.0 48255.6 48421.0 65834.0 70994.0 71064.3 71555.6 71839.3 6616.4 6751.8 7971.4 8063.8 8123.6 12364.8 12412.9 12451.5 12603.6 12770.7 10861.5 11102.5 11188.8 11219.6 11239.4 10461.8 10574.8 10766.7 10954.0 11088.9 10071.0 11131.0 11251.5 11453.9 11471.4 7838.3 8048.4 8069.5 8078.1 8259.5 11037.6 11058.9 11287.5 11302.6 11334.8 17:34:06 INFO - PROCESS | 1669 | 17:34:06 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:6141.03 Median:5537.61 stddev:3252.36 (58.7%) stddev-sans-first:3243.31 17:34:06 INFO - PROCESS | 1669 | Values: 1567.0 1585.4 1848.5 1940.0 1967.6 8133.2 8831.2 8974.6 9212.9 9215.6 8747.7 8847.4 8889.6 8933.0 8999.1 2494.9 2496.9 2512.2 2519.8 2523.2 2459.6 2514.4 2520.2 2550.3 2550.4 2480.0 2518.7 2527.3 2530.6 2556.4 2506.6 2519.7 2529.3 2552.0 2562.3 2508.7 2546.2 2548.5 2550.5 2561.7 9131.6 9134.8 9184.2 9185.1 9186.4 5454.1 5504.0 5522.4 5552.8 5645.6 3592.1 3696.2 3740.3 3758.3 3766.3 1057.2 1076.0 1076.8 1084.8 1085.5 11972.2 12186.6 12439.3 12443.1 12448.4 4958.3 5026.6 5043.1 5099.3 5100.7 10511.8 10535.6 10557.4 10560.7 10592.0 5582.9 5613.6 5714.1 5719.8 5736.3 4163.5 4531.1 5089.1 5097.5 5167.9 3269.0 3310.3 3958.5 4047.1 4096.1 1338.9 1339.8 1341.3 1350.5 1352.8 985.3 1142.4 1173.0 1325.4 1438.0 8431.9 8484.9 8485.6 8545.1 8561.1 518.7 520.3 523.4 524.5 538.3 5422.4 6314.8 6373.4 6424.3 6458.2 8982.4 9226.4 9647.2 10824.2 10983.8 8836.9 9484.4 10726.6 10859.7 11050.1 8489.3 8612.0 8647.8 8652.1 8662.1 7993.6 8156.1 8179.6 8184.3 8241.5 9611.1 9867.0 9906.8 9978.2 10061.4 9272.9 9502.6 9986.5 10142.4 10480.2 6933.5 7418.2 7674.3 7685.3 7768.8 8285.1 8555.1 8558.7 8573.3 8582.0 6077.9 6404.9 7474.7 7556.2 7715.6 7420.5 7425.0 7445.6 7463.3 7466.8 7891.3 7958.7 8036.2 8051.1 8076.9 6824.5 6998.7 7207.1 7258.5 7270.8 7136.3 7201.6 7260.8 7358.3 7366.9 17:34:06 INFO - PROCESS | 1669 | 17:34:06 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5830.51 Median:6593.24 stddev:1920.42 (29.1%) stddev-sans-first:1880.31 17:34:06 INFO - PROCESS | 1669 | Values: 293.7 332.1 334.5 339.1 343.5 6730.2 6755.6 6772.4 6840.1 6896.9 6763.9 6778.5 6791.6 6815.2 6840.1 4739.3 4786.0 4902.8 4911.2 5016.0 4870.9 4879.7 4889.5 4898.0 4901.7 4819.4 4831.8 4839.2 4843.2 4851.5 4842.9 4850.2 4861.3 4868.3 4874.1 4227.4 4233.7 4243.1 4245.2 4247.6 5054.5 6238.9 6259.6 6410.1 6424.1 5026.0 5593.2 5792.5 5843.4 5854.4 5697.3 6394.0 7092.8 7095.6 7120.8 3403.0 3772.0 4492.9 4551.2 4571.2 6035.8 6583.2 7518.7 7550.8 7574.7 4517.0 4684.0 4743.2 4844.5 4848.7 3930.3 4059.8 4765.5 4765.6 4772.0 4620.3 5704.5 5763.1 5786.0 5807.6 5820.8 7270.1 7281.4 7281.7 7307.5 1650.2 1672.4 1672.7 1675.1 1678.9 1031.8 1066.6 1072.6 1074.0 1083.2 6603.3 6639.9 6714.6 6718.5 6722.0 6608.5 7460.7 7462.1 7467.3 7478.3 5365.8 6010.2 6112.4 6772.6 6853.4 3697.2 3995.1 4005.9 4022.6 4026.8 7998.1 8006.2 8018.0 8018.9 8025.2 6326.6 7606.6 7882.6 7883.9 7889.5 6491.6 7934.8 7993.4 8011.9 8045.8 6809.8 7521.0 7547.8 7557.9 7586.6 6805.3 7463.4 7479.4 7482.0 7488.4 7685.7 7997.9 8021.4 8022.1 8028.1 4706.7 4730.1 4730.5 4741.7 4771.1 7561.5 7575.8 7580.5 7584.5 7585.7 7236.2 7294.4 7311.5 7311.5 7325.7 5812.9 7025.4 7270.7 7317.0 7356.3 7134.3 7140.8 7150.1 7190.5 7191.4 7279.0 7298.1 7300.8 7308.2 7354.1 7070.0 7088.0 7154.8 7156.1 7176.3 17:34:06 INFO - PROCESS | 1669 | 17:34:06 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:18579.93 Median:71240.97 stddev:26998.75 (37.9%) stddev-sans-first:27040.79 17:34:06 INFO - PROCESS | 1669 | Values: 615.7 656.3 689.8 726.0 750.5 12167.4 15114.5 15248.7 15342.9 15355.8 13696.8 13964.3 14056.0 14073.6 14530.4 868.2 882.4 903.3 913.7 917.3 888.8 904.1 904.1 905.4 906.8 923.5 945.9 953.9 958.5 961.0 917.9 918.8 922.5 950.1 956.2 689.9 707.9 717.9 719.7 720.9 14731.6 14808.3 14829.6 14869.3 14883.8 12661.5 12684.4 12721.0 12759.6 12834.6 9973.4 10066.5 10069.1 10128.5 10453.8 3446.1 3495.4 3500.8 3542.9 3606.7 79805.0 81462.0 81760.6 82445.6 84083.2 9452.9 9488.2 9536.1 9651.8 9667.6 20880.6 20960.9 21354.6 21360.6 21396.0 7598.7 7618.0 7741.0 7771.8 7822.0 4092.4 4119.3 4123.2 4143.5 4163.7 3000.3 3599.3 3607.4 3643.3 3682.1 636.6 637.9 639.2 649.1 657.1 532.9 594.0 608.7 608.9 620.7 7875.0 7965.7 8115.8 8374.7 8376.0 523.1 559.8 596.3 617.5 648.2 3621.9 3764.7 3878.9 3959.3 3995.0 92083.5 92844.5 93602.1 93902.5 96866.6 84975.6 85259.6 85378.0 86549.6 86919.0 72783.6 73782.3 74258.0 74636.3 74789.6 7566.4 7822.8 7877.8 7975.2 8081.9 49568.3 51684.0 52034.7 52332.0 52676.5 71221.0 71260.9 71331.6 71796.3 72948.3 9741.8 9809.3 9905.5 9983.9 10101.4 10219.9 10394.2 10727.2 10841.0 10994.0 8218.9 10201.5 10257.7 10298.0 10355.4 8316.9 10058.3 10190.1 10321.9 10337.5 8252.9 9242.8 9583.9 10116.5 10557.4 7703.7 8467.5 8498.5 8694.9 8789.3 7338.0 8842.4 9022.9 9354.7 9735.8 17:34:06 INFO - PROCESS | 1669 | -------- Summary: end -------- 17:34:06 INFO - PROCESS | 1669 | 17:34:06 INFO - TEST-INFO | 1669: exit 0 17:34:06 INFO - TEST-OK | dromaeo_css | took 1111518ms 17:34:06 INFO - TEST-START | kraken 17:34:06 INFO - operating with platform_type : mac_ 17:34:06 INFO - Initialising browser for kraken test... 17:34:06 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/tmphppyYt/profile http://localhost:49270/getInfo.html) 17:34:08 INFO - PROCESS | 1682 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:34:09 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 17:34:09 INFO - PROCESS | 1682 | colorDepth:24 17:34:09 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 17:34:09 INFO - PROCESS | 1682 | __metrics 17:34:09 ERROR - PROCESS | 1682 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 17:34:10 INFO - TEST-INFO | 1682: exit 0 17:34:10 INFO - Browser initialized. 17:34:10 INFO - Running cycle 1/1 for kraken test... 17:34:10 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/tmphppyYt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:34:22 INFO - PROCESS | 1685 | RSS: Main: 254558208 17:34:22 INFO - PROCESS | 1685 | 17:34:25 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 17:34:25 INFO - PROCESS | 1685 | RSS: Main: 266571776 17:34:25 INFO - PROCESS | 1685 | 17:34:28 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 17:34:29 INFO - PROCESS | 1685 | RSS: Main: 275943424 17:34:29 INFO - PROCESS | 1685 | 17:34:32 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 17:34:32 INFO - PROCESS | 1685 | RSS: Main: 279031808 17:34:32 INFO - PROCESS | 1685 | 17:34:34 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 17:34:35 INFO - PROCESS | 1685 | RSS: Main: 280891392 17:34:35 INFO - PROCESS | 1685 | 17:34:37 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:34:38 INFO - PROCESS | 1685 | RSS: Main: 281120768 17:34:38 INFO - PROCESS | 1685 | 17:34:40 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 17:34:41 INFO - PROCESS | 1685 | RSS: Main: 281407488 17:34:41 INFO - PROCESS | 1685 | 17:34:44 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 17:34:45 INFO - PROCESS | 1685 | RSS: Main: 281653248 17:34:45 INFO - PROCESS | 1685 | 17:34:47 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 17:34:48 INFO - PROCESS | 1685 | RSS: Main: 281640960 17:34:48 INFO - PROCESS | 1685 | 17:34:50 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:34:50 INFO - PROCESS | 1685 | RSS: Main: 281669632 17:34:50 INFO - PROCESS | 1685 | 17:34:52 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:34:53 INFO - PROCESS | 1685 | RSS: Main: 281509888 17:34:53 INFO - PROCESS | 1685 | 17:34:55 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:34:56 INFO - PROCESS | 1685 | RSS: Main: 281563136 17:34:56 INFO - PROCESS | 1685 | 17:34:58 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:34:59 INFO - PROCESS | 1685 | RSS: Main: 282095616 17:34:59 INFO - PROCESS | 1685 | 17:35:02 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:35:02 INFO - PROCESS | 1685 | RSS: Main: 281931776 17:35:02 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 17:35:04 INFO - PROCESS | 1685 | RSS: Main: 283521024 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | __start_tp_report 17:35:04 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 17:35:04 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 17:35:04 INFO - PROCESS | 1685 | |i|pagename|runs| 17:35:04 INFO - PROCESS | 1685 | |0;ai-astar;114;108;117;115;115;127;115;115;116;117 17:35:04 INFO - PROCESS | 1685 | |1;audio-beat-detection;155;121;149;185;153;176;138;126;165;113 17:35:04 INFO - PROCESS | 1685 | |2;audio-dft;194;193;195;197;208;244;276;199;201;195 17:35:04 INFO - PROCESS | 1685 | |3;audio-fft;59;57;66;78;65;124;69;85;88;90 17:35:04 INFO - PROCESS | 1685 | |4;audio-oscillator;84;88;137;82;80;82;121;85;86;100 17:35:04 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;90;86;89;88;89;86;90;86;89;94 17:35:04 INFO - PROCESS | 1685 | |6;imaging-darkroom;95;102;96;95;94;124;109;153;96;138 17:35:04 INFO - PROCESS | 1685 | |7;imaging-desaturate;91;92;92;94;96;91;97;103;91;94 17:35:04 INFO - PROCESS | 1685 | |8;json-parse-financial;57;59;67;88;87;88;59;67;60;57 17:35:04 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;71;72;68;78;78;76;72;68;69;69 17:35:04 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;88;86;83;98;114;108;76;111;113;112 17:35:04 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;122;142;140;121;153;139;128;113;113;138 17:35:04 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;161;181;151;148;142;143;145;146;180;156 17:35:04 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;69;86;101;57;86;73;92;100;101;78 17:35:04 INFO - PROCESS | 1685 | __end_tp_report 17:35:04 INFO - PROCESS | 1685 | __start_cc_report 17:35:04 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,974 17:35:04 INFO - PROCESS | 1685 | __end_cc_report 17:35:04 INFO - PROCESS | 1685 | __startTimestamp1458952504866__endTimestamp 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | ------- Summary: start ------- 17:35:04 INFO - PROCESS | 1685 | Number of tests: 14 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:115.90 Median:115.50 stddev:4.65 (4.0%) stddev-sans-first:4.88 17:35:04 INFO - PROCESS | 1685 | Values: 114.0 108.0 117.0 115.0 115.0 127.0 115.0 115.0 116.0 117.0 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:154.00 stddev:23.70 (15.4%) stddev-sans-first:25.00 17:35:04 INFO - PROCESS | 1685 | Values: 155.0 121.0 149.0 185.0 153.0 176.0 138.0 126.0 165.0 113.0 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:210.20 Median:200.00 stddev:27.65 (13.8%) stddev-sans-first:28.70 17:35:04 INFO - PROCESS | 1685 | Values: 194.0 193.0 195.0 197.0 208.0 244.0 276.0 199.0 201.0 195.0 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:78.10 Median:73.50 stddev:20.01 (27.2%) stddev-sans-first:20.00 17:35:04 INFO - PROCESS | 1685 | Values: 59.0 57.0 66.0 78.0 65.0 124.0 69.0 85.0 88.0 90.0 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:83.00 stddev:19.37 (23.3%) stddev-sans-first:20.17 17:35:04 INFO - PROCESS | 1685 | Values: 84.0 88.0 137.0 82.0 80.0 82.0 121.0 85.0 86.0 100.0 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:89.00 stddev:2.45 (2.8%) stddev-sans-first:2.55 17:35:04 INFO - PROCESS | 1685 | Values: 90.0 86.0 89.0 88.0 89.0 86.0 90.0 86.0 89.0 94.0 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:110.20 Median:94.50 stddev:21.06 (22.3%) stddev-sans-first:21.61 17:35:04 INFO - PROCESS | 1685 | Values: 95.0 102.0 96.0 95.0 94.0 124.0 109.0 153.0 96.0 138.0 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:93.00 stddev:3.78 (4.1%) stddev-sans-first:3.84 17:35:04 INFO - PROCESS | 1685 | Values: 91.0 92.0 92.0 94.0 96.0 91.0 97.0 103.0 91.0 94.0 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:67.00 stddev:13.43 (20.0%) stddev-sans-first:13.53 17:35:04 INFO - PROCESS | 1685 | Values: 57.0 59.0 67.0 88.0 87.0 88.0 59.0 67.0 60.0 57.0 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:72.00 stddev:3.93 (5.5%) stddev-sans-first:4.15 17:35:04 INFO - PROCESS | 1685 | Values: 71.0 72.0 68.0 78.0 78.0 76.0 72.0 68.0 69.0 69.0 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:98.90 Median:79.50 stddev:14.49 (18.2%) stddev-sans-first:14.83 17:35:04 INFO - PROCESS | 1685 | Values: 88.0 86.0 83.0 98.0 114.0 108.0 76.0 111.0 113.0 112.0 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:138.50 stddev:13.49 (9.7%) stddev-sans-first:13.91 17:35:04 INFO - PROCESS | 1685 | Values: 122.0 142.0 140.0 121.0 153.0 139.0 128.0 113.0 113.0 138.0 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:153.50 stddev:14.51 (9.5%) stddev-sans-first:15.25 17:35:04 INFO - PROCESS | 1685 | Values: 161.0 181.0 151.0 148.0 142.0 143.0 145.0 146.0 180.0 156.0 17:35:04 INFO - PROCESS | 1685 | 17:35:04 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.30 Median:75.50 stddev:14.97 (19.8%) stddev-sans-first:14.82 17:35:04 INFO - PROCESS | 1685 | Values: 69.0 86.0 101.0 57.0 86.0 73.0 92.0 100.0 101.0 78.0 17:35:04 INFO - PROCESS | 1685 | -------- Summary: end -------- 17:35:04 INFO - PROCESS | 1685 | 17:35:05 INFO - TEST-INFO | 1685: exit 0 17:35:05 INFO - TEST-OK | kraken | took 58903ms 17:35:05 INFO - SUITE-END | took 1170s 17:35:06 INFO - Completed test suite (00:19:30) 17:35:06 INFO - javascript benchmark 17:35:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2899.4780939430893, 3521.2429327694545, 3521.806300653464, 3528.9294214115716, 3606.873759418421, 4542.795574199161, 5861.296644402667, 5878.265216847894, 5881.735321910513, 5951.1668366428685, 4829.444613869406, 5764.942350576493, 5855.092460668592, 5968.40315968403, 5977.671228082454, 5243.79024839006, 5309.62832601718, 5354.491323324278, 5364.812231571896, 5402.756875940592, 5274.367075950891, 5443.129099344106, 5454.509094181523, 5475.6440831345835, 5490.066688662937, 5208.088584497736, 5281.102212623863, 5308.336457942757, 5340.439253878345, 5344.118220493614, 5331.653442526263, 5345.251664766935, 5348.973255133699, 5350.117230656937, 5359.249705041298, 5236.293100431431, 5306.495882891119, 5314.681119132826, 5333.57331413486, 5386.0, 4324.567543245682, 5440.483154100354, 5743.5118014968775, 5791.247137872049, 5800.970995144998, 5710.628809127435, 6257.78097766576, 6282.560220784547, 6284.497240220817, 6303.779367722108, 6229.750809967596, 6305.833420817117, 6312.684365781738, 6313.747450101991, 6326.114343991845, 5792.507636850831, 5906.291245050621, 5959.970200148971, 5986.850328741816, 6012.669303188279, 6374.330695277022, 6408.455281301049, 6431.389018043278, 6433.035044743232, 6450.032495125769, 5427.7244847460815, 6273.341299163613, 6284.402981716729, 6290.622562646256, 6304.464120549713, 6229.7508099676415, 6268.561200715997, 6296.653684047421, 6325.493960483151, 6327.335629758901, 6132.4778862607845, 6231.906521402183, 6241.563090583615, 6326.177596912464, 6355.142055822497, 4714.976425117852, 5192.9740351298005, 5326.6005049621435, 6279.120923070774, 6327.683615819191, 4297.269464191032, 4793.448753393334, 4907.87730306738, 4928.802847886116, 4995.300657907896, 4422.159789639958, 4474.619657329098, 4476.395686582335, 4480.39514665516, 4502.594766471033, 5966.254218222723, 5983.700814959235, 5983.880322393527, 6000.0, 6010.128531362928, 6111.40942266768, 6219.689015549295, 6269.811905642747, 6288.434040936246, 6312.147860038836, 5958.344582095966, 5994.0, 6000.669963151981, 6012.518998480111, 6049.395060494004, 5473.0969390050195, 5474.479924407175, 5476.67139971603, 5480.150576660624, 5492.642978206483, 6290.150829637941, 6398.968005159944, 6447.387498187759, 6469.838254043687, 6476.255230648536, 6248.094026366242, 6261.0, 6285.717142728497, 6291.1192433058495, 6295.0, 6290.899092658675, 6399.360063993563, 6455.322191169859, 6460.67696615158, 6468.579542329733, 6249.906251406142, 6292.27638821523, 6299.559030867796, 6338.841528961812, 6343.9682801585695, 5220.895582088413, 6046.637201767908, 6249.218847644044, 6278.937210628018, 6299.842503937438, 6078.787242446493, 6146.494108943338, 6191.950464396292, 6273.404026617464, 6281.277653069956, 6030.396960303934, 6136.3965394158, 6175.475084617858, 6185.536084793748, 6240.500759939103, 5964.463198312173, 6082.756689732361, 6096.664683442275, 6118.785842495491, 6149.877002460015, 6230.190075290183, 6246.531510136849, 6284.685765711788, 6299.716512757029, 6321.367863213642, 5986.610870293417, 6080.331163571915, 6108.0688921796145, 6136.417040381157, 6154.692265386623], "unit": "score", "name": "dojo.html", "value": 5749.3549489615525}, {"lowerIsBetter": false, "replicates": [461.5453778028642, 512.7487531109755, 544.5697898660056, 563.5632384901701, 598.9010166344757, 37933.0, 38619.613803861954, 38739.644112456066, 38742.80628596853, 38801.89584833213, 39058.80470597643, 39506.0, 39587.812365629004, 39653.0, 39683.007924801896, 9372.671956481525, 9526.523673816317, 9627.566759495805, 9632.662856800014, 9643.662471813488, 9444.0, 9592.568334424932, 9659.90340096597, 9718.271129665303, 9742.733444652185, 9619.519024048805, 9635.373700709466, 9654.082862128087, 9687.612495500172, 9769.02309769021, 9626.229901607889, 9670.56482458291, 9686.854697179548, 9737.415755054684, 9745.707628771077, 9530.904690953072, 9559.044095590454, 9577.616895324249, 9600.42397456148, 9717.56270967808, 38577.807110964546, 38676.0, 38855.0, 39131.0, 39188.21623567513, 3412.3516531859113, 3500.3699334119847, 3680.355937710917, 3783.959411161925, 4150.0, 28856.134315970554, 29143.854280728672, 29300.827966881297, 29327.560086598718, 29692.406151876843, 2760.9585856212175, 2771.7782577393964, 2796.258991367289, 2797.8740956656998, 2867.311845157147, 489802.0, 493640.0, 494653.52673236764, 496352.0, 497052.0, 45375.77312113418, 65061.0, 65418.36454088591, 65579.67210163918, 65601.34398656047, 46368.768156159, 46553.0, 47284.52715472801, 47604.0, 47753.522464775604, 16077.758833617505, 16291.348346066261, 16294.185290735415, 16314.83685163157, 16350.264238109314, 12673.746525069448, 13049.0, 13133.737325253442, 13145.145565538209, 13167.0, 11984.700382490508, 12013.579524716593, 14813.777793333109, 14945.0, 15090.849091508944, 5156.097682905476, 6259.561830671809, 6304.873902521924, 6312.274088479791, 6319.9368006320265, 762.7177944160696, 824.8020475086056, 921.8018126102786, 977.2231076294363, 982.2387649571497, 29494.0, 29575.816967321065, 29730.702692973227, 29990.85004574963, 30204.09387718372, 1012.4583347908833, 1024.8419286206538, 1076.7092884921028, 1078.9514471848786, 1109.9500522476508, 14791.334389952477, 14867.405303787944, 14890.776638350433, 15248.771268430983, 15259.694806104038, 514560.0, 523262.0, 526722.0, 527168.0, 528291.0, 58684.0, 58838.705806470694, 59031.0, 59526.404735952085, 59556.70221648864, 1409.457358916804, 1415.9362828672733, 1467.8091848059898, 1470.4265336518765, 1472.5508719840552, 26817.731822681522, 28727.0, 28947.421051579273, 29441.411171776872, 29625.40749184961, 50328.0, 51564.22653660123, 51867.703307417614, 51898.481015190875, 51960.74019629878, 483571.0, 484690.0, 486973.0, 487664.0, 489604.0, 31676.841615791775, 31784.36431271408, 31948.520772188902, 32628.184295392806, 33293.50059749154, 44000.779996099816, 44523.55476445194, 45191.77404112958, 45411.318830216915, 45478.77260613676, 34304.656953430145, 37440.0, 37607.811960940024, 38542.42186367151, 38582.2283554333, 33521.16197095092, 36801.26397472089, 36975.07562310964, 36981.445278321386, 37696.0, 30287.848560757055, 31616.051518454482, 36819.89540313795, 37062.44406333961, 37161.4425783608, 28244.85877570599, 28256.29359266035, 28768.705408257098, 30937.381252375275, 31102.222444438165, 23776.64335034941, 24562.140325088538, 24675.506489869742, 25001.624975625746, 25005.87497062576], "unit": "score", "name": "ext.html", "value": 19125.071534289913}, {"lowerIsBetter": false, "replicates": [361.1476914481824, 364.58073215801824, 364.9124210189555, 372.7409450431949, 379.1544854973411, 19131.13033045044, 19494.90252548737, 20125.295614653507, 20621.484462888435, 20660.586788264263, 11817.172797904128, 11897.464614092365, 12277.386130693452, 12285.324307163124, 12319.384030798446, 5183.17069268917, 5304.20436934459, 5430.0768869292315, 6127.4791642710425, 6131.448169664729, 5885.8822823543505, 5956.017257152586, 5972.283326000865, 5995.910061349084, 6022.367651396606, 5980.222571065756, 6045.848853778669, 6582.374674405948, 6595.53831231814, 6621.205455345341, 6501.739930402779, 6511.641859697715, 6558.442532384753, 6574.572652777578, 6585.176852893388, 4998.525434996648, 5066.746662666888, 5259.2899958505495, 5284.625997240707, 5382.327209098863, 11039.668809935714, 11551.249168804, 18865.056747162726, 23812.40468988272, 24591.893364798627, 2062.3091264426434, 2134.253011445997, 2251.864888106719, 2259.5819773341987, 2744.862756862149, 9641.27690423221, 9692.90307096927, 10191.745206369826, 10195.286329956905, 10263.538140783683, 1459.7956286119952, 1715.7254839225664, 1750.4573582189435, 1762.171779263744, 1771.3977247735702, 101302.0, 107415.0, 109302.0, 119564.0, 134047.0, 15275.61810954735, 18390.448286551426, 18927.337543185924, 18963.525911852314, 19050.237990480226, 28566.714332856405, 29018.854905725337, 29070.12789616315, 29837.552436713468, 29957.700422995928, 10319.535620897077, 10404.531796069195, 10594.894051059391, 10848.566057357775, 10899.400532970603, 9286.396384235004, 9306.953465232766, 9336.439813611205, 9353.251739860794, 9426.915904670914, 7724.725420305586, 8087.312578430781, 8666.739997800076, 8717.215450609476, 8795.824083518293, 3182.363527294504, 3456.3605732939486, 3470.392681280766, 3667.303212389691, 3695.815209239527, 872.2760109109424, 944.4569372610639, 1007.7430255284855, 1065.6749691344214, 1088.455772113943, 19193.136308866135, 19689.01554922248, 19868.205271789255, 19891.801081988993, 20074.79925200729, 976.5166242709904, 1010.5149528226345, 1014.573878970834, 1018.3126389686931, 1048.7745134796055, 8993.685221017233, 9863.358881672812, 10193.133583645325, 10890.891091088988, 10908.890911090946, 592932.0, 628210.0, 630110.0, 645686.0, 651058.4894151093, 105655.88688226347, 112444.43777781223, 116673.0, 118745.4062729698, 119614.0, 946.7159852044359, 1036.3315661398356, 1049.1711547877244, 1056.3820165203288, 1059.7774467361787, 17614.471565853044, 17744.733828992317, 17905.462836114937, 18136.818631813512, 18213.81786182121, 42305.730828075204, 44222.89442763956, 46393.0, 48255.55233343005, 48421.0, 65834.0, 70994.0, 71064.28935710783, 71555.64222178856, 71839.28160718326, 6616.437602803816, 6751.831204219934, 7971.362291016821, 8063.838723225385, 8123.5532045738055, 12364.81452778227, 12412.937935310265, 12451.501939922664, 12603.621891343275, 12770.68073298175, 10861.511231994422, 11102.500387482743, 11188.832167517656, 11219.55121795119, 11239.381833999209, 10461.843072354073, 10574.788504229718, 10766.73083172927, 10954.014138727553, 11088.944555277172, 10071.0, 11131.0, 11251.49368278413, 11453.942730286295, 11471.369074700971, 7838.3337416320255, 8048.436609437517, 8069.515829050276, 8078.071021832329, 8259.463134896212, 11037.558497660004, 11058.944705276423, 11287.492062857355, 11302.604408845651, 11334.773304533699], "unit": "score", "name": "jquery.html", "value": 9934.352699690176}, {"lowerIsBetter": false, "replicates": [1566.9686606267876, 1585.389624994377, 1848.5286252005737, 1939.9903000485003, 1967.5572996075894, 8133.227343402382, 8831.249343805785, 8974.551272436376, 9212.861807072892, 9215.631374745002, 8747.737567872973, 8847.380683352168, 8889.59996800144, 8933.017368089504, 8999.14508121729, 2494.87525623719, 2496.9375765605823, 2512.1584269269815, 2519.8236123471365, 2523.205190365029, 2459.5818710819112, 2514.421683012908, 2520.1683444463283, 2550.2731721459386, 2550.4389034412397, 2479.962800557993, 2518.7103483099495, 2527.304991127436, 2530.6204069389646, 2556.399246177147, 2506.6114752213434, 2519.735427780084, 2529.3297276221815, 2552.0, 2562.3209849389928, 2508.7240403555593, 2546.2106746908516, 2548.503041906829, 2550.4516528946365, 2561.6541766861424, 9131.634734610607, 9134.77163070922, 9184.219341355993, 9185.081491850828, 9186.356955013152, 5454.072807622674, 5504.0, 5522.420145884705, 5552.805651802168, 5645.604807663465, 3592.1378869071496, 3696.1888674549546, 3740.2706472237924, 3758.32350176968, 3766.322062028834, 1057.1595581512715, 1075.9731006724817, 1076.784643071389, 1084.788466249074, 1085.5006696919427, 11972.221805582609, 12186.634400967985, 12439.315837628927, 12443.066769992378, 12448.439820208021, 4958.330625365529, 5026.648134630614, 5043.117454445457, 5099.3370861787735, 5100.69395836251, 10511.84232236517, 10535.578576856993, 10557.419341936267, 10560.683179504627, 10592.0, 5582.888342233133, 5613.550915926716, 5714.085746280658, 5719.828405147852, 5736.282964629421, 4163.458750362433, 4531.093781243764, 5089.134847076006, 5097.46476619957, 5167.870803229949, 3268.950965735516, 3310.337932413479, 3958.5051868516434, 4047.1096358801015, 4096.05790668148, 1338.8594197609305, 1339.8459177194552, 1341.3494455189225, 1350.5003148834994, 1352.8444228913802, 985.2512090811035, 1142.3945308986251, 1172.9882701173049, 1325.3638253638114, 1437.9568612941628, 8431.873521897176, 8484.915150848412, 8485.575721213914, 8545.145485451529, 8561.0582835888, 518.7302602646678, 520.2560338715673, 523.4137765702437, 524.5384062025394, 538.3459097196925, 5422.3764267109, 6314.842128946813, 6373.426391624776, 6424.3254458282145, 6458.160439142881, 8982.371234013557, 9226.40028398152, 9647.179989700813, 10824.18818588609, 10983.835242471368, 8836.91163088361, 9484.430934143835, 10726.624568140078, 10859.728506787393, 11050.115990720724, 8489.278411334983, 8612.0, 8647.827043459221, 8652.134786521297, 8662.133786621287, 7993.600319984093, 8156.143604921398, 8179.631916563888, 8184.304334131427, 8241.464304820167, 9611.134997850228, 9866.950665246628, 9906.75233119149, 9978.151857092229, 10061.446620435947, 9272.907270927204, 9502.619895204114, 9986.450745209084, 10142.442165680959, 10480.213983951387, 6933.514653974174, 7418.221086786026, 7674.309312161932, 7685.308322251024, 7768.805779855549, 8285.088640249689, 8555.144485551395, 8558.657653693783, 8573.271271941954, 8582.013068496954, 6077.878442431038, 6404.943184374526, 7474.738384156529, 7556.206598307099, 7715.57564333967, 7420.480566360519, 7425.0, 7445.590492522963, 7463.290987356192, 7466.775996720107, 7891.289783919475, 7958.721444749637, 8036.236557527026, 8051.074126475296, 8076.919230807616, 6824.454043676593, 6998.6850591724515, 7207.099112610924, 7258.45561582894, 7270.781876543712, 7136.286371362822, 7201.6399180041835, 7260.782176534713, 7358.337749602561, 7366.926330736624], "unit": "score", "name": "mootools.html", "value": 4925.5740433000165}, {"lowerIsBetter": false, "replicates": [293.69309072019735, 332.09007319943345, 334.5216340632894, 339.07094560903136, 343.5190732973836, 6730.192376914771, 6755.560888542242, 6772.390484856362, 6840.144981877265, 6896.931030689691, 6763.8985415218685, 6778.45772338213, 6791.558548694331, 6815.216250131237, 6840.110785597865, 4739.31279964405, 4785.9521404785855, 4902.828401005965, 4911.214205727084, 5015.974920125394, 4870.902581948359, 4879.658423910328, 4889.511048895118, 4898.0, 4901.730404827733, 4819.373481447407, 4831.806727730886, 4839.201531747258, 4843.249296359052, 4851.466338702758, 4842.854714358575, 4850.223964165734, 4861.295112208745, 4868.318435419044, 4874.073925954075, 4227.393590435646, 4233.666395085538, 4243.066525364415, 4245.15096980602, 4247.617714405718, 5054.519820617035, 6238.9376106238815, 6259.561830671855, 6410.102585638015, 6424.068510066061, 5026.0, 5593.216949627055, 5792.507636850873, 5843.4448727371255, 5854.414558544111, 5697.287839020122, 6393.9680301598655, 7092.822679433004, 7095.574265544033, 7120.750773722895, 3403.0, 3772.038130276762, 4492.876780804799, 4551.249043907785, 4571.1771881061395, 6035.758569657209, 6583.210014798207, 7518.699252029912, 7550.7734767957045, 7574.734884279023, 4516.96109894726, 4683.953160468352, 4743.217369134123, 4844.539768721966, 4848.7090774553635, 3930.292547341506, 4059.837606495766, 4765.451973023078, 4765.618750499952, 4771.976140119277, 4620.306953956866, 5704.486596206361, 5763.135529670583, 5786.04530252512, 5807.5644326675665, 5820.767169313265, 7270.054892864, 7281.381082607932, 7281.672324745399, 7307.525010874276, 1650.1666658337463, 1672.3895778040928, 1672.690552247838, 1675.1456757053747, 1678.924448399825, 1031.8091153136693, 1066.5520481397677, 1072.5977758340623, 1073.9624113156, 1083.1551389915878, 6603.273639899608, 6639.900401493981, 6714.630695311805, 6718.49611279156, 6722.0253063305545, 6608.504362172856, 7460.664270107858, 7462.067241594801, 7467.290607392289, 7478.2895624915545, 5365.812196573179, 6010.188624535719, 6112.419320164666, 6772.5936443813525, 6853.417459515997, 3697.186618943828, 3995.06116062725, 4005.8597949072227, 4022.577629348935, 4026.778527181033, 7998.080220774569, 8006.15935326794, 8017.959910200529, 8018.879716804253, 8025.157358477392, 6326.557141000178, 7606.581638009962, 7882.605869706492, 7883.881741773878, 7889.526628402315, 6491.578047426997, 7934.801629959182, 7993.440459167802, 8011.879821802678, 8045.798855028554, 6809.774240636733, 7521.0, 7547.811304717206, 7557.886631700419, 7586.62066896664, 6805.2854450283985, 7463.440241981764, 7479.439042071757, 7482.0, 7488.400927925644, 7685.654145563575, 7997.880031799644, 8021.358291336795, 8022.117567067501, 8028.076771171156, 4706.741129237925, 4730.124926888537, 4730.526947305242, 4741.739204343794, 4771.117343291502, 7561.508501947355, 7575.8106047347055, 7580.507267027626, 7584.469087163846, 7585.734499292498, 7236.20401755817, 7294.416446684147, 7311.4516411268305, 7311.488195826454, 7325.743598974011, 5812.94187058124, 7025.367716905503, 7270.709171633075, 7317.0, 7356.337929586363, 7134.250903655042, 7140.8214794628475, 7150.10623672041, 7190.532615379983, 7191.3887319578425, 7279.017332660235, 7298.087739032621, 7300.758870991838, 7308.196098429275, 7354.080739907512, 7069.9646501767165, 7088.0, 7154.821129471805, 7156.141263048259, 7176.318249766264], "unit": "score", "name": "prototype.html", "value": 5194.036398077691}, {"lowerIsBetter": false, "replicates": [615.7438824797416, 656.310873582738, 689.8137502874224, 725.974590889319, 750.4934169435631, 12167.391630418477, 15114.47099351523, 15248.69502609947, 15342.923285383586, 15355.846441535581, 13696.794548081787, 13964.301784910765, 14056.0, 14073.577792666236, 14530.418783248684, 868.2272777228256, 882.386741214856, 903.3044555692113, 913.6939125393002, 917.2707697380598, 888.7911340834899, 904.1230006893303, 904.1275169461468, 905.3933864310894, 906.7869050773063, 923.487464457226, 945.9385139965915, 953.909378609031, 958.515949445529, 961.0437614573474, 917.9311551633588, 918.8392031394479, 922.5295099499236, 950.1211379473993, 956.1824639932862, 689.8620275944832, 707.9079719636466, 717.9030830837822, 719.6617589732817, 720.8882623193414, 14731.631709207248, 14808.3336249869, 14829.629259268497, 14869.256537173207, 14883.776743348859, 12661.493540258378, 12684.42920068599, 12721.0, 12759.553415630407, 12834.614961551168, 9973.401595904268, 10066.547005384775, 10069.09378155962, 10128.493575321278, 10453.84319235212, 3446.138465383654, 3495.405781017233, 3500.8249587520777, 3542.946855797165, 3606.747527673064, 79805.0, 81462.0, 81760.59119704422, 82445.58777206135, 84083.15916840815, 9452.8582071269, 9488.193503552136, 9536.141747242782, 9651.758706032266, 9667.613295468103, 20880.582388352148, 20960.895195523924, 21354.572908542053, 21360.572788544454, 21396.0, 7598.734044308423, 7617.961910190414, 7741.0, 7771.805704857424, 7822.0, 4092.4270602115726, 4119.320312148462, 4123.154753275571, 4143.544210136883, 4163.666906647461, 3000.264935090873, 3599.2981368632863, 3607.3867442534834, 3643.2713457308114, 3682.0978860179425, 636.5766765101156, 637.91069250305, 639.2105749399487, 649.0880313160018, 657.135866335767, 532.9387120481117, 594.04655527878, 608.7230310208845, 608.9056196289582, 620.7175735040636, 7874.960625196837, 7965.681372745141, 8115.756527304072, 8374.706885258987, 8376.036755773164, 523.0506630465693, 559.8306660600164, 596.3172167867767, 617.5245061302771, 648.2221334398646, 3621.855125794939, 3764.698824094066, 3878.864239751595, 3959.346707793182, 3994.980025099856, 92083.53958230166, 92844.53577732068, 93602.12795744183, 93902.53048734849, 96866.57833554076, 84975.57512212523, 85259.57370213109, 85378.0, 86549.56725216334, 86919.0, 72783.63608182031, 73782.26217737861, 74258.0, 74636.25363746402, 74789.62605187048, 7566.394688425023, 7822.843543129219, 7877.803054923673, 7975.202479751978, 8081.87877181831, 49568.26511072095, 51684.0, 52034.69913252199, 52332.0, 52676.473235267156, 71221.0, 71260.93108603479, 71331.64334178295, 71796.28203718105, 72948.27051729415, 9741.756456088371, 9809.264305176997, 9905.455199964072, 9983.92889029961, 10101.444420556645, 10219.897801021894, 10394.22043346737, 10727.195460340661, 10841.024307812335, 10994.010539051524, 8218.917810822055, 10201.489925503844, 10257.662840023502, 10298.0, 10355.43045132525, 8316.91880055589, 10058.34620749649, 10190.133838623504, 10321.948390258001, 10337.483125843528, 8252.917470825216, 9242.815143697222, 9583.856242156513, 10116.494175291353, 10557.41934193596, 7703.730369437043, 8467.53428561435, 8498.490090594583, 8694.91305086941, 8789.296856251613, 7338.0, 8842.425242359226, 9022.86465703028, 9354.672586459441, 9735.756606084904], "unit": "score", "name": "yui.html", "value": 6773.435660417587}], "name": "dromaeo_css", "value": 7577.531757891197}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 117.0, 115.0, 115.0, 127.0, 115.0, 115.0, 116.0, 117.0], "unit": "score", "name": "ai-astar", "value": 115.9}, {"lowerIsBetter": true, "replicates": [155.0, 121.0, 149.0, 185.0, 153.0, 176.0, 138.0, 126.0, 165.0, 113.0], "unit": "score", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [194.0, 193.0, 195.0, 197.0, 208.0, 244.0, 276.0, 199.0, 201.0, 195.0], "unit": "score", "name": "audio-dft", "value": 210.2}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 66.0, 78.0, 65.0, 124.0, 69.0, 85.0, 88.0, 90.0], "unit": "score", "name": "audio-fft", "value": 78.1}, {"lowerIsBetter": true, "replicates": [84.0, 88.0, 137.0, 82.0, 80.0, 82.0, 121.0, 85.0, 86.0, 100.0], "unit": "score", "name": "audio-oscillator", "value": 94.5}, {"lowerIsBetter": true, "replicates": [90.0, 86.0, 89.0, 88.0, 89.0, 86.0, 90.0, 86.0, 89.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.7}, {"lowerIsBetter": true, "replicates": [95.0, 102.0, 96.0, 95.0, 94.0, 124.0, 109.0, 153.0, 96.0, 138.0], "unit": "score", "name": "imaging-darkroom", "value": 110.2}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 92.0, 94.0, 96.0, 91.0, 97.0, 103.0, 91.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 94.1}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 67.0, 88.0, 87.0, 88.0, 59.0, 67.0, 60.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 68.9}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 68.0, 78.0, 78.0, 76.0, 72.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.1}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 83.0, 98.0, 114.0, 108.0, 76.0, 111.0, 113.0, 112.0], "unit": "score", "name": "stanford-crypto-aes", "value": 98.9}, {"lowerIsBetter": true, "replicates": [122.0, 142.0, 140.0, 121.0, 153.0, 139.0, 128.0, 113.0, 113.0, 138.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.9}, {"lowerIsBetter": true, "replicates": [161.0, 181.0, 151.0, 148.0, 142.0, 143.0, 145.0, 146.0, 180.0, 156.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.3}, {"lowerIsBetter": true, "replicates": [69.0, 86.0, 101.0, 57.0, 86.0, 73.0, 92.0, 100.0, 101.0, 78.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 84.3}], "name": "kraken", "value": 1550.2}]} 17:35:06 INFO - Return code: 0 17:35:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:35:06 ERROR - # TBPL SUCCESS # 17:35:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:35:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:35:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:35:06 INFO - 2016-03-25 17:35:06.146 screenresolution[1690:10305] starting screenresolution argv=screenresolution get 17:35:06 INFO - 2016-03-25 17:35:06.149 screenresolution[1690:10305] Display 0: 1600x1200x32@60 17:35:06 INFO - 2016-03-25 17:35:06.154 screenresolution[1691:10308] starting screenresolution argv=screenresolution list 17:35:06 INFO - Available Modes on Display 0 17:35:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:35:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:35:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:35:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:35:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:35:06 INFO - Intel Iris: 17:35:06 INFO - Chipset Model: Intel Iris 17:35:06 INFO - Type: GPU 17:35:06 INFO - Bus: Built-In 17:35:06 INFO - VRAM (Dynamic, Max): 1536 MB 17:35:06 INFO - Vendor: Intel (0x8086) 17:35:06 INFO - Device ID: 0x0a2e 17:35:06 INFO - Revision ID: 0x0009 17:35:06 INFO - Displays: 17:35:06 INFO - Display: 17:35:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:35:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:35:06 INFO - Display Serial Number: 1600x1200 60 17:35:06 INFO - Main Display: Yes 17:35:06 INFO - Mirror: Off 17:35:06 INFO - Online: Yes 17:35:06 INFO - Rotation: Supported 17:35:06 INFO - Return code: 0 17:35:06 INFO - Running post-action listener: _resource_record_post_action 17:35:06 INFO - Running post-run listener: _resource_record_post_run 17:35:07 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 39245312; Write bytes: 708549632; Read time: 435; Write time: 2129 17:35:07 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 396298752; Write bytes: 390325760; Read time: 30245; Write time: 771 17:35:07 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 37430784; Write bytes: 302990848; Read time: 413; Write time: 1294 17:35:07 INFO - Running post-run listener: _upload_blobber_files 17:35:07 INFO - Blob upload gear active. 17:35:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:35:07 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:35:07 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:35:07 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:35:07 INFO - (blobuploader) - INFO - Open directory for files ... 17:35:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:35:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:35:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:08 INFO - (blobuploader) - INFO - Done attempting. 17:35:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:35:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:35:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:09 INFO - (blobuploader) - INFO - Done attempting. 17:35:09 INFO - (blobuploader) - INFO - Iteration through files over. 17:35:09 INFO - Return code: 0 17:35:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:35:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:35:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e1e68d5b37711b9ec1222c1526870351d9d3b2dacdda607e35181d857364849dad24cf2fa965587a2c2d5e69eeef5c8eafc633be7d00a463356ddbf43fd54f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0efeab2ac38a56b5b709caf41e8b2b91bb93dd301bde86f4552f846940bbd9c9e8a79ef701a476fe5e94014c457209c7c38d03a78a65acfb1f9da7c1046d122"} 17:35:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:35:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:35:09 INFO - Contents: 17:35:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e1e68d5b37711b9ec1222c1526870351d9d3b2dacdda607e35181d857364849dad24cf2fa965587a2c2d5e69eeef5c8eafc633be7d00a463356ddbf43fd54f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0efeab2ac38a56b5b709caf41e8b2b91bb93dd301bde86f4552f846940bbd9c9e8a79ef701a476fe5e94014c457209c7c38d03a78a65acfb1f9da7c1046d122"} 17:35:09 INFO - Running post-run listener: copy_logs_to_upload_dir 17:35:09 INFO - Copying logs to upload dir... 17:35:09 INFO - mkdir: /builds/slave/test/build/upload/logs 17:35:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.138496 ========= master_lag: 0.61 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-03-25 17:35:10.319741) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 17:35:10.322839) ========= 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.5AKiIcER0P/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.G8YIzUazPM/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e1e68d5b37711b9ec1222c1526870351d9d3b2dacdda607e35181d857364849dad24cf2fa965587a2c2d5e69eeef5c8eafc633be7d00a463356ddbf43fd54f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0efeab2ac38a56b5b709caf41e8b2b91bb93dd301bde86f4552f846940bbd9c9e8a79ef701a476fe5e94014c457209c7c38d03a78a65acfb1f9da7c1046d122"} build_url:https://queue.taskcluster.net/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011011 build_url: 'https://queue.taskcluster.net/v1/task/FjWElt47QpaQk_kguGnRrg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e1e68d5b37711b9ec1222c1526870351d9d3b2dacdda607e35181d857364849dad24cf2fa965587a2c2d5e69eeef5c8eafc633be7d00a463356ddbf43fd54f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0efeab2ac38a56b5b709caf41e8b2b91bb93dd301bde86f4552f846940bbd9c9e8a79ef701a476fe5e94014c457209c7c38d03a78a65acfb1f9da7c1046d122"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 17:35:10.381137) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:35:10.381474) ========= 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.5AKiIcER0P/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.G8YIzUazPM/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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.005145 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:35:10.460816) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 17:35:10.461136) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 17:35:10.472605) ========= ========= Total master_lag: 0.97 =========