builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0054 starttime: 1456883373.89 results: success (0) buildid: 20160301162132 builduid: faff1d1677c2491dbaff1ae081d8d4ab revision: 2750be25944cafd09d3d793a4ecc33b11ae5f44b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:33.887928) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:33.888407) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:33.888741) ========= 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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.006092 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:33.912540) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:33.912927) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:33.928786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:33.929191) ========= 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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.005298 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:33.978192) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:33.978535) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:33.978955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:33.979278) ========= 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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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-01 17:49:33-- 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.1M=0.001s 2016-03-01 17:49:34 (11.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134698 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:34.129624) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:34.130003) ========= 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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.020680 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:34.181460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-01 17:49:34.181877) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2750be25944cafd09d3d793a4ecc33b11ae5f44b --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 2750be25944cafd09d3d793a4ecc33b11ae5f44b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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-01 17:49:34,258 truncating revision to first 12 chars 2016-03-01 17:49:34,258 Setting DEBUG logging. 2016-03-01 17:49:34,258 attempt 1/10 2016-03-01 17:49:34,258 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2750be25944c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 17:49:35,345 unpacking tar archive at: fx-team-2750be25944c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.336721 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-01 17:49:35.536593) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:35.537017) ========= echo 2750be25944cafd09d3d793a4ecc33b11ae5f44b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2750be25944cafd09d3d793a4ecc33b11ae5f44b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 2750be25944cafd09d3d793a4ecc33b11ae5f44b program finished with exit code 0 elapsedTime=0.005220 script_repo_revision: '2750be25944cafd09d3d793a4ecc33b11ae5f44b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:35.588854) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:35.589212) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 17:49:35.602329) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-01 17:49:35.602637) ========= /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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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:49:35 INFO - MultiFileLogger online at 20160301 17:49:35 in /builds/slave/test 17:49:35 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:49:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:49:35 INFO - {'append_to_log': False, 17:49:35 INFO - 'base_work_dir': '/builds/slave/test', 17:49:35 INFO - 'blob_upload_branch': 'Fx-Team', 17:49:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:49:35 INFO - 'branch': 'Fx-Team', 17:49:35 INFO - 'buildbot_json_path': 'buildprops.json', 17:49:35 INFO - 'config_files': ('talos/mac_config.py',), 17:49:35 INFO - 'default_actions': ('clobber', 17:49:35 INFO - 'read-buildbot-config', 17:49:35 INFO - 'download-and-extract', 17:49:35 INFO - 'populate-webroot', 17:49:35 INFO - 'create-virtualenv', 17:49:35 INFO - 'install', 17:49:35 INFO - 'run-tests'), 17:49:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:49:35 INFO - 'download_minidump_stackwalk': True, 17:49:35 INFO - 'download_symbols': 'ondemand', 17:49:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:49:35 INFO - 'tooltool.py': '/tools/tooltool.py', 17:49:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:49:35 INFO - '/tools/misc-python/virtualenv.py')}, 17:49:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:49:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:49:35 INFO - 'installer_path': 'installer.exe', 17:49:35 INFO - 'log_level': 'info', 17:49:35 INFO - 'log_name': 'talos', 17:49:35 INFO - 'log_to_console': True, 17:49:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:49:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:49:35 INFO - 'opt_config_files': (), 17:49:35 INFO - 'pip_index': False, 17:49:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:49:35 INFO - 'cmd': ('bash', 17:49:35 INFO - '-c', 17:49:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:49:35 INFO - 'enabled': True, 17:49:35 INFO - 'halt_on_failure': False, 17:49:35 INFO - 'name': 'check_screen_resolution'},), 17:49:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:49:35 INFO - 'cmd': ('bash', 17:49:35 INFO - '-c', 17:49:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:49:35 INFO - 'enabled': True, 17:49:35 INFO - 'halt_on_failure': False, 17:49:35 INFO - 'name': 'check_screen_resolution'},), 17:49:35 INFO - 'run_cmd_checks_enabled': True, 17:49:35 INFO - 'sps_profile': False, 17:49:35 INFO - 'sps_profile_interval': 0, 17:49:35 INFO - 'suite': 'dromaeojs-e10s', 17:49:35 INFO - 'system_bits': '32', 17:49:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:49:35 INFO - 'title': 't-yosemite-r7-0054', 17:49:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:49:35 INFO - 'use_talos_json': True, 17:49:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:49:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:49:35 INFO - 'work_dir': 'build'} 17:49:35 INFO - ##### 17:49:35 INFO - ##### Running clobber step. 17:49:35 INFO - ##### 17:49:35 INFO - Running pre-action listener: _resource_record_pre_action 17:49:35 INFO - Running main action method: clobber 17:49:35 INFO - rmtree: /builds/slave/test/build 17:49:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:49:37 INFO - Running post-action listener: _resource_record_post_action 17:49:37 INFO - ##### 17:49:37 INFO - ##### Running read-buildbot-config step. 17:49:37 INFO - ##### 17:49:37 INFO - Running pre-action listener: _resource_record_pre_action 17:49:37 INFO - Running main action method: read_buildbot_config 17:49:37 INFO - Using buildbot properties: 17:49:37 INFO - { 17:49:37 INFO - "project": "", 17:49:37 INFO - "product": "firefox", 17:49:37 INFO - "script_repo_revision": "production", 17:49:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:49:37 INFO - "repository": "", 17:49:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:49:37 INFO - "buildid": "20160301162132", 17:49:37 INFO - "pgo_build": "False", 17:49:37 INFO - "basedir": "/builds/slave/test", 17:49:37 INFO - "buildnumber": 478, 17:49:37 INFO - "slavename": "t-yosemite-r7-0054", 17:49:37 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:49:37 INFO - "platform": "yosemite_r7", 17:49:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:49:37 INFO - "branch": "fx-team", 17:49:37 INFO - "repo_path": "integration/fx-team", 17:49:37 INFO - "revision": "2750be25944cafd09d3d793a4ecc33b11ae5f44b", 17:49:37 INFO - "stage_platform": "macosx64", 17:49:37 INFO - "builduid": "faff1d1677c2491dbaff1ae081d8d4ab", 17:49:37 INFO - "slavebuilddir": "test" 17:49:37 INFO - } 17:49:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 17:49:37 INFO - Running post-action listener: _resource_record_post_action 17:49:37 INFO - ##### 17:49:37 INFO - ##### Running download-and-extract step. 17:49:37 INFO - ##### 17:49:37 INFO - Running pre-action listener: _resource_record_pre_action 17:49:37 INFO - Running main action method: download_and_extract 17:49:37 INFO - mkdir: /builds/slave/test/build/tests 17:49:37 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:49:37 INFO - https://queue.taskcluster.net/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:49:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 17:49:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 17:49:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 17:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 17:49:38 INFO - Downloaded 1277 bytes. 17:49:38 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 17:49:38 INFO - Using the following test package requirements: 17:49:38 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:49:38 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:49:38 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 17:49:38 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:49:38 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 17:49:38 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:49:38 INFO - u'jsshell-mac.zip'], 17:49:38 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:49:38 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 17:49:38 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:49:38 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:49:38 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 17:49:38 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:49:38 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 17:49:38 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:49:38 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 17:49:38 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:49:38 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:49:38 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 17:49:38 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:38 INFO - https://queue.taskcluster.net/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:49:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:49:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:49:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:49:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:49:39 INFO - Downloaded 17851807 bytes. 17:49:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:49:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:49:43 INFO - Return code: 0 17:49:43 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:43 INFO - https://queue.taskcluster.net/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:49:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:49:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:49:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:49:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:49:44 INFO - Downloaded 17851807 bytes. 17:49:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:49:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:49:47 INFO - Return code: 0 17:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:47 INFO - https://queue.taskcluster.net/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:49:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:49:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:49:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:49:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:49:48 INFO - Downloaded 10808456 bytes. 17:49:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:49:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:49:48 INFO - Return code: 0 17:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:48 INFO - https://queue.taskcluster.net/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:49:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:49:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:49:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 17:49:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 17:49:51 INFO - Downloaded 110996160 bytes. 17:49:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:49:51 INFO - mkdir: /builds/slave/test/properties 17:49:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:49:51 INFO - Writing to file /builds/slave/test/properties/build_url 17:49:51 INFO - Contents: 17:49:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:49:52 INFO - Running post-action listener: _resource_record_post_action 17:49:52 INFO - Running post-action listener: set_extra_try_arguments 17:49:52 INFO - ##### 17:49:52 INFO - ##### Running populate-webroot step. 17:49:52 INFO - ##### 17:49:52 INFO - Running pre-action listener: _resource_record_pre_action 17:49:52 INFO - Running main action method: populate_webroot 17:49:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:49:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:49:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:49:52 INFO - '--tppagecycles', 17:49:52 INFO - '7'], 17:49:52 INFO - 'tests': ['tsvgm']}}, 17:49:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:49:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:49:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:49:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:49:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:49:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:49:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:49:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:52 INFO - 'talos_options': ['--e10s'], 17:49:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:49:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:52 INFO - 'tests': ['damp', 'tps']}, 17:49:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:52 INFO - 'talos_options': ['--e10s'], 17:49:52 INFO - 'tests': ['damp', 'tps']}, 17:49:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:49:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:49:52 INFO - 'other': {'tests': ['a11yr', 17:49:52 INFO - 'ts_paint', 17:49:52 INFO - 'tpaint', 17:49:52 INFO - 'sessionrestore', 17:49:52 INFO - 'sessionrestore_no_auto_restore']}, 17:49:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:49:52 INFO - 'tests': ['a11yr', 17:49:52 INFO - 'ts_paint', 17:49:52 INFO - 'tpaint', 17:49:52 INFO - 'sessionrestore', 17:49:52 INFO - 'sessionrestore_no_auto_restore']}, 17:49:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:49:52 INFO - 'tests': ['a11yr', 17:49:52 INFO - 'ts_paint', 17:49:52 INFO - 'tpaint', 17:49:52 INFO - 'sessionrestore', 17:49:52 INFO - 'sessionrestore_no_auto_restore']}, 17:49:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:49:52 INFO - 'tests': ['a11yr', 17:49:52 INFO - 'ts_paint', 17:49:52 INFO - 'tpaint', 17:49:52 INFO - 'sessionrestore', 17:49:52 INFO - 'sessionrestore_no_auto_restore']}, 17:49:52 INFO - 'other_l64': {'tests': ['a11yr', 17:49:52 INFO - 'ts_paint', 17:49:52 INFO - 'tpaint', 17:49:52 INFO - 'sessionrestore', 17:49:52 INFO - 'sessionrestore_no_auto_restore']}, 17:49:52 INFO - 'other_nol64': {'tests': ['a11yr', 17:49:52 INFO - 'ts_paint', 17:49:52 INFO - 'tpaint', 17:49:52 INFO - 'sessionrestore', 17:49:52 INFO - 'sessionrestore_no_auto_restore']}, 17:49:52 INFO - 'svgr': {'tests': ['tsvgx', 17:49:52 INFO - 'tsvgr_opacity', 17:49:52 INFO - 'tart', 17:49:52 INFO - 'tscrollx', 17:49:52 INFO - 'cart']}, 17:49:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:49:52 INFO - 'tests': ['tsvgx', 17:49:52 INFO - 'tsvgr_opacity', 17:49:52 INFO - 'tart', 17:49:52 INFO - 'tscrollx', 17:49:52 INFO - 'cart']}, 17:49:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:52 INFO - 'tests': ['tp5o']}, 17:49:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:52 INFO - 'talos_options': ['--e10s'], 17:49:52 INFO - 'tests': ['tp5o']}, 17:49:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:52 INFO - 'talos_options': ['--xperf_path', 17:49:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:49:52 INFO - 'tests': ['tp5n']}, 17:49:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:52 INFO - 'talos_options': ['--e10s', 17:49:52 INFO - '--xperf_path', 17:49:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:49:52 INFO - 'tests': ['tp5n']}}, 17:49:52 INFO - 'talos.zip': {'path': '', 17:49:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:49:52 INFO - Running post-action listener: _resource_record_post_action 17:49:52 INFO - ##### 17:49:52 INFO - ##### Running create-virtualenv step. 17:49:52 INFO - ##### 17:49:52 INFO - Running pre-action listener: _resource_record_pre_action 17:49:52 INFO - Running main action method: create_virtualenv 17:49:52 INFO - Creating virtualenv /builds/slave/test/build/venv 17:49:52 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:49:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:49:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:49:52 INFO - Using real prefix '/tools/python27' 17:49:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:49:53 INFO - Installing distribute.............................................................................................................................................................................................done. 17:49:55 INFO - Installing pip.................done. 17:49:55 INFO - Return code: 0 17:49:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:55 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 0x1020ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb4dc860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f51d30>, '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 0x101d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f48b20>, '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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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:49:55 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:49:55 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:49:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YwAQ4mGgcq/Render', 17:49:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:49:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:49:55 INFO - 'HOME': '/Users/cltbld', 17:49:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:49:55 INFO - 'LOGNAME': 'cltbld', 17:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:55 INFO - 'MOZ_NO_REMOTE': '1', 17:49:55 INFO - 'NO_EM_RESTART': '1', 17:49:55 INFO - 'PAGER': '/bin/cat', 17:49:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:55 INFO - 'PWD': '/builds/slave/test', 17:49:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:49:55 INFO - 'SHELL': '/bin/bash', 17:49:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYJIDcjRTy/Listeners', 17:49:55 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 17:49:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:49:55 INFO - 'USER': 'cltbld', 17:49:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:49:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:55 INFO - 'XPC_FLAGS': '0x0', 17:49:55 INFO - 'XPC_SERVICE_NAME': '0', 17:49:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:56 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:49:56 INFO - Cleaning up... 17:49:56 INFO - Return code: 0 17:49:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:49:56 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:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:56 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:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:56 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 0x1020ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb4dc860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f51d30>, '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 0x101d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f48b20>, '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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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:49:56 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:49:56 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:49:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YwAQ4mGgcq/Render', 17:49:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:49:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:49:56 INFO - 'HOME': '/Users/cltbld', 17:49:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:49:56 INFO - 'LOGNAME': 'cltbld', 17:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:56 INFO - 'MOZ_NO_REMOTE': '1', 17:49:56 INFO - 'NO_EM_RESTART': '1', 17:49:56 INFO - 'PAGER': '/bin/cat', 17:49:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:56 INFO - 'PWD': '/builds/slave/test', 17:49:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:49:56 INFO - 'SHELL': '/bin/bash', 17:49:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYJIDcjRTy/Listeners', 17:49:56 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 17:49:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:49:56 INFO - 'USER': 'cltbld', 17:49:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:49:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:56 INFO - 'XPC_FLAGS': '0x0', 17:49:56 INFO - 'XPC_SERVICE_NAME': '0', 17:49:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:56 INFO - Downloading/unpacking psutil>=0.7.1 17:49:56 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:49:56 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:49:56 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:49:56 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:49:56 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:49:56 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:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:49:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:49:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:49:58 INFO - Installing collected packages: psutil 17:49:58 INFO - Running setup.py install for psutil 17:49:59 INFO - building 'psutil._psutil_osx' extension 17:49:59 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:49:59 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:49:59 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:49:59 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:49:59 INFO - building 'psutil._psutil_posix' extension 17:49:59 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:49:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:49:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:49:59 INFO - ^ 17:49:59 INFO - 1 warning generated. 17:49:59 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:49:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:49:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:49:59 INFO - Successfully installed psutil 17:49:59 INFO - Cleaning up... 17:49:59 INFO - Return code: 0 17:49:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:59 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 0x1020ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb4dc860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f51d30>, '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 0x101d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f48b20>, '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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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:49:59 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:49:59 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:49:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YwAQ4mGgcq/Render', 17:49:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:49:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:49:59 INFO - 'HOME': '/Users/cltbld', 17:49:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:49:59 INFO - 'LOGNAME': 'cltbld', 17:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:59 INFO - 'MOZ_NO_REMOTE': '1', 17:49:59 INFO - 'NO_EM_RESTART': '1', 17:49:59 INFO - 'PAGER': '/bin/cat', 17:49:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:59 INFO - 'PWD': '/builds/slave/test', 17:49:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:49:59 INFO - 'SHELL': '/bin/bash', 17:49:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYJIDcjRTy/Listeners', 17:49:59 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 17:49:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:49:59 INFO - 'USER': 'cltbld', 17:49:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:49:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:59 INFO - 'XPC_FLAGS': '0x0', 17:49:59 INFO - 'XPC_SERVICE_NAME': '0', 17:49:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:50:00 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:50:00 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:50:00 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:50:00 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:50:00 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:50:00 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:50:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:50:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:50:02 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:50:02 INFO - Installing collected packages: mozsystemmonitor 17:50:02 INFO - Running setup.py install for mozsystemmonitor 17:50:02 INFO - Successfully installed mozsystemmonitor 17:50:02 INFO - Cleaning up... 17:50:02 INFO - Return code: 0 17:50:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:50: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:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50: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:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:02 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 0x1020ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb4dc860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f51d30>, '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 0x101d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f48b20>, '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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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:50:02 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:50:02 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:50:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YwAQ4mGgcq/Render', 17:50:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:02 INFO - 'HOME': '/Users/cltbld', 17:50:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:02 INFO - 'LOGNAME': 'cltbld', 17:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:02 INFO - 'MOZ_NO_REMOTE': '1', 17:50:02 INFO - 'NO_EM_RESTART': '1', 17:50:02 INFO - 'PAGER': '/bin/cat', 17:50:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:02 INFO - 'PWD': '/builds/slave/test', 17:50:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:02 INFO - 'SHELL': '/bin/bash', 17:50:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYJIDcjRTy/Listeners', 17:50:02 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 17:50:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:02 INFO - 'USER': 'cltbld', 17:50:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:02 INFO - 'XPC_FLAGS': '0x0', 17:50:02 INFO - 'XPC_SERVICE_NAME': '0', 17:50:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:02 INFO - Downloading/unpacking blobuploader==1.2.4 17:50:02 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:50:02 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:50:02 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:50:02 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:50:02 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:50:02 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:50:05 INFO - Downloading blobuploader-1.2.4.tar.gz 17:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:50:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:50:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:50:06 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:50:06 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:50:06 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:50:06 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:50:06 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:50:06 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:50:06 INFO - Downloading docopt-0.6.1.tar.gz 17:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:50:06 INFO - Installing collected packages: blobuploader, requests, docopt 17:50:06 INFO - Running setup.py install for blobuploader 17:50:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:50:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:50:06 INFO - Running setup.py install for requests 17:50:07 INFO - Running setup.py install for docopt 17:50:07 INFO - Successfully installed blobuploader requests docopt 17:50:07 INFO - Cleaning up... 17:50:07 INFO - Return code: 0 17:50:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:07 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:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:07 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:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:07 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 0x1020ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb4dc860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f51d30>, '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 0x101d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f48b20>, '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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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:50:07 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:50:07 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:50:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YwAQ4mGgcq/Render', 17:50:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:07 INFO - 'HOME': '/Users/cltbld', 17:50:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:07 INFO - 'LOGNAME': 'cltbld', 17:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:07 INFO - 'MOZ_NO_REMOTE': '1', 17:50:07 INFO - 'NO_EM_RESTART': '1', 17:50:07 INFO - 'PAGER': '/bin/cat', 17:50:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:07 INFO - 'PWD': '/builds/slave/test', 17:50:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:07 INFO - 'SHELL': '/bin/bash', 17:50:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYJIDcjRTy/Listeners', 17:50:07 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 17:50:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:07 INFO - 'USER': 'cltbld', 17:50:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:07 INFO - 'XPC_FLAGS': '0x0', 17:50:07 INFO - 'XPC_SERVICE_NAME': '0', 17:50:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:50:07 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-QTwshj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:50:07 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-sy4h_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:50:07 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-OnxSsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:50:08 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-qF7f3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:50:08 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-1LY2LX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:50:08 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-mYfSqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:50:08 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-WjQItX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:50:08 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-VMEXfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:50:08 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-zuF78c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:50:08 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-u3YXk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:50:08 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-ZmDH9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:50:08 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-Vl_ctj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:50:08 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-48rd3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:50:09 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-EDCRlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:09 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-veCceH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:50:09 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-BMAQJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:50:09 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-dINzNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:50:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:50:09 INFO - Running setup.py install for manifestparser 17:50:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:50:09 INFO - Running setup.py install for mozcrash 17:50:09 INFO - Running setup.py install for mozdebug 17:50:09 INFO - Running setup.py install for mozdevice 17:50:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:50:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:50:10 INFO - Running setup.py install for mozfile 17:50:10 INFO - Running setup.py install for mozhttpd 17:50:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:50:10 INFO - Running setup.py install for mozinfo 17:50:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:50:10 INFO - Running setup.py install for mozInstall 17:50:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:50:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:50:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:50:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:50:10 INFO - Running setup.py install for mozleak 17:50:10 INFO - Running setup.py install for mozlog 17:50:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:50:10 INFO - Running setup.py install for moznetwork 17:50:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:50:11 INFO - Running setup.py install for mozprocess 17:50:11 INFO - Running setup.py install for mozprofile 17:50:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:50:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:50:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:50:11 INFO - Running setup.py install for mozrunner 17:50:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:50:11 INFO - Running setup.py install for mozscreenshot 17:50:11 INFO - Running setup.py install for moztest 17:50:11 INFO - Running setup.py install for mozversion 17:50:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:50:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:50:12 INFO - Cleaning up... 17:50:12 INFO - Return code: 0 17:50:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:12 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:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:12 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:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:12 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 0x1020ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb4dc860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f51d30>, '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 0x101d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f48b20>, '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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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:50:12 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:50:12 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:50:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YwAQ4mGgcq/Render', 17:50:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:12 INFO - 'HOME': '/Users/cltbld', 17:50:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:12 INFO - 'LOGNAME': 'cltbld', 17:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:12 INFO - 'MOZ_NO_REMOTE': '1', 17:50:12 INFO - 'NO_EM_RESTART': '1', 17:50:12 INFO - 'PAGER': '/bin/cat', 17:50:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:12 INFO - 'PWD': '/builds/slave/test', 17:50:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:12 INFO - 'SHELL': '/bin/bash', 17:50:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYJIDcjRTy/Listeners', 17:50:12 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 17:50:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:12 INFO - 'USER': 'cltbld', 17:50:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:12 INFO - 'XPC_FLAGS': '0x0', 17:50:12 INFO - 'XPC_SERVICE_NAME': '0', 17:50:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:50:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-4QksrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:50:12 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:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:50:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-mqA0kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:50:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-xlg2Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:50:12 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:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:50:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-hquYDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:50:12 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:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:50:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-8oE5Cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:50:12 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:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:50:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-Wp1WKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:50:12 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:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:50:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-oqWOkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:50:13 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:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:50:13 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-jAtKE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:50:13 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:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:50:13 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-xcbujd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:50:13 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:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:50:13 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-2R0GCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:50:13 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:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:50:13 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-0DmhZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:50:13 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:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:50:13 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-t1Bz0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:50:13 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:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:50:13 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-4jGb55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:50:13 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:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:50:13 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-BeDmXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:50:13 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:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:13 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-z0kslR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:13 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:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:50:13 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-a6K4tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:50:14 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:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:50:14 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-stYL3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:50:14 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:50:14 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:50:14 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:50:14 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:50:14 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:50:14 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:50:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:16 INFO - Downloading blessings-1.6.tar.gz 17:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:50:16 INFO - Installing collected packages: blessings 17:50:16 INFO - Running setup.py install for blessings 17:50:16 INFO - Successfully installed blessings 17:50:16 INFO - Cleaning up... 17:50:16 INFO - Return code: 0 17:50:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:50:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:50:17 INFO - Reading from file tmpfile_stdout 17:50:17 INFO - Current package versions: 17:50:17 INFO - blessings == 1.6 17:50:17 INFO - blobuploader == 1.2.4 17:50:17 INFO - docopt == 0.6.1 17:50:17 INFO - manifestparser == 1.1 17:50:17 INFO - mozInstall == 1.12 17:50:17 INFO - mozcrash == 0.16 17:50:17 INFO - mozdebug == 0.1 17:50:17 INFO - mozdevice == 0.48 17:50:17 INFO - mozfile == 1.2 17:50:17 INFO - mozhttpd == 0.7 17:50:17 INFO - mozinfo == 0.9 17:50:17 INFO - mozleak == 0.1 17:50:17 INFO - mozlog == 3.1 17:50:17 INFO - moznetwork == 0.27 17:50:17 INFO - mozprocess == 0.22 17:50:17 INFO - mozprofile == 0.28 17:50:17 INFO - mozrunner == 6.11 17:50:17 INFO - mozscreenshot == 0.1 17:50:17 INFO - mozsystemmonitor == 0.0 17:50:17 INFO - moztest == 0.7 17:50:17 INFO - mozversion == 1.4 17:50:17 INFO - psutil == 3.1.1 17:50:17 INFO - requests == 1.2.3 17:50:17 INFO - wsgiref == 0.1.2 17:50:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:17 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 0x1020ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb4dc860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f51d30>, '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 0x101d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f48b20>, '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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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:50:17 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:50:17 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:50:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YwAQ4mGgcq/Render', 17:50:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:17 INFO - 'HOME': '/Users/cltbld', 17:50:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:17 INFO - 'LOGNAME': 'cltbld', 17:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:17 INFO - 'MOZ_NO_REMOTE': '1', 17:50:17 INFO - 'NO_EM_RESTART': '1', 17:50:17 INFO - 'PAGER': '/bin/cat', 17:50:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:17 INFO - 'PWD': '/builds/slave/test', 17:50:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:17 INFO - 'SHELL': '/bin/bash', 17:50:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYJIDcjRTy/Listeners', 17:50:17 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 17:50:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:17 INFO - 'USER': 'cltbld', 17:50:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:17 INFO - 'XPC_FLAGS': '0x0', 17:50:17 INFO - 'XPC_SERVICE_NAME': '0', 17:50:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:17 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:50:17 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:50:17 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:50:17 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:50:17 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:50:17 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:50:17 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:50:17 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:50:17 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:50:17 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:50:17 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:50:17 INFO - Cleaning up... 17:50:17 INFO - Return code: 0 17:50:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb4dc860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f51d30>, '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 0x101d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f48b20>, '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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:50:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YwAQ4mGgcq/Render', 17:50:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:17 INFO - 'HOME': '/Users/cltbld', 17:50:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:17 INFO - 'LOGNAME': 'cltbld', 17:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:17 INFO - 'MOZ_NO_REMOTE': '1', 17:50:17 INFO - 'NO_EM_RESTART': '1', 17:50:17 INFO - 'PAGER': '/bin/cat', 17:50:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:17 INFO - 'PWD': '/builds/slave/test', 17:50:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:17 INFO - 'SHELL': '/bin/bash', 17:50:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYJIDcjRTy/Listeners', 17:50:17 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 17:50:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:17 INFO - 'USER': 'cltbld', 17:50:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:17 INFO - 'XPC_FLAGS': '0x0', 17:50:17 INFO - 'XPC_SERVICE_NAME': '0', 17:50:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:17 INFO - Downloading/unpacking jsonschema 17:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:50:19 INFO - Downloading/unpacking functools32 (from jsonschema) 17:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:20 INFO - Downloading functools32-3.2.3-2.tar.gz 17:50:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:50:20 INFO - warning: no files found matching '*.txt' 17:50:20 INFO - no previously-included directories found matching 'build' 17:50:20 INFO - no previously-included directories found matching 'dist' 17:50:20 INFO - no previously-included directories found matching '.git*' 17:50:20 INFO - Installing collected packages: jsonschema, functools32 17:50:20 INFO - Running setup.py install for functools32 17:50:20 INFO - warning: no files found matching '*.txt' 17:50:20 INFO - no previously-included directories found matching 'build' 17:50:20 INFO - no previously-included directories found matching 'dist' 17:50:20 INFO - no previously-included directories found matching '.git*' 17:50:20 INFO - Successfully installed jsonschema functools32 17:50:20 INFO - Cleaning up... 17:50:20 INFO - Return code: 0 17:50:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:50:20 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:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:20 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:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:20 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 0x1020ada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb4dc860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f51d30>, '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 0x101d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f48b20>, '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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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:50:20 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:50:20 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:50:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YwAQ4mGgcq/Render', 17:50:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:20 INFO - 'HOME': '/Users/cltbld', 17:50:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:20 INFO - 'LOGNAME': 'cltbld', 17:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:20 INFO - 'MOZ_NO_REMOTE': '1', 17:50:20 INFO - 'NO_EM_RESTART': '1', 17:50:20 INFO - 'PAGER': '/bin/cat', 17:50:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:20 INFO - 'PWD': '/builds/slave/test', 17:50:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:20 INFO - 'SHELL': '/bin/bash', 17:50:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYJIDcjRTy/Listeners', 17:50:20 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 17:50:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:20 INFO - 'USER': 'cltbld', 17:50:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:20 INFO - 'XPC_FLAGS': '0x0', 17:50:20 INFO - 'XPC_SERVICE_NAME': '0', 17:50:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:20 INFO - Downloading/unpacking flake8 17:50:21 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:50:21 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:50:21 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:50:21 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:50:21 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:50:21 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:50:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:50:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:50:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:50:24 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:50:24 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:50:24 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:50:24 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:50:24 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:50:24 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:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:50:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:50:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:50:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:50:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:50:24 INFO - no previously-included directories found matching 'docs/_build' 17:50:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:50:24 INFO - Running setup.py install for pep8 17:50:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:50:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:50:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:50:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:50:24 INFO - no previously-included directories found matching 'docs/_build' 17:50:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:50:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:50:24 INFO - Cleaning up... 17:50:24 INFO - Return code: 0 17:50:24 INFO - Running post-action listener: _resource_record_post_action 17:50:24 INFO - Running post-action listener: _start_resource_monitoring 17:50:24 INFO - Starting resource monitoring. 17:50:24 INFO - ##### 17:50:24 INFO - ##### Running install step. 17:50:24 INFO - ##### 17:50:24 INFO - Running pre-action listener: _resource_record_pre_action 17:50:24 INFO - Running main action method: install 17:50:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:50:25 INFO - Reading from file tmpfile_stdout 17:50:25 INFO - Detecting whether we're running mozinstall >=1.0... 17:50:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:50:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:50:25 INFO - Reading from file tmpfile_stdout 17:50:25 INFO - Output received: 17:50:25 INFO - Usage: mozinstall [options] installer 17:50:25 INFO - Options: 17:50:25 INFO - -h, --help show this help message and exit 17:50:25 INFO - -d DEST, --destination=DEST 17:50:25 INFO - Directory to install application into. [default: 17:50:25 INFO - "/builds/slave/test"] 17:50:25 INFO - --app=APP Application being installed. [default: firefox] 17:50:25 INFO - mkdir: /builds/slave/test/build/application 17:50:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:50:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:50:58 INFO - Reading from file tmpfile_stdout 17:50:58 INFO - Output received: 17:50:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:50:58 INFO - Running post-action listener: _resource_record_post_action 17:50:58 INFO - ##### 17:50:58 INFO - ##### Running run-tests step. 17:50:58 INFO - ##### 17:50:58 INFO - Running pre-action listener: _resource_record_pre_action 17:50:58 INFO - Running main action method: run_tests 17:50:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:50:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:50:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:50:58 INFO - 2016-03-01 17:50:58.888 screenresolution[2290:70145] starting screenresolution argv=screenresolution get 17:50:58 INFO - 2016-03-01 17:50:58.890 screenresolution[2290:70145] Display 0: 1600x1200x32@60 17:50:58 INFO - 2016-03-01 17:50:58.896 screenresolution[2291:70148] starting screenresolution argv=screenresolution list 17:50:58 INFO - Available Modes on Display 0 17:50:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:50:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:50:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:50:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:50:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:50:59 INFO - Intel Iris: 17:50:59 INFO - Chipset Model: Intel Iris 17:50:59 INFO - Type: GPU 17:50:59 INFO - Bus: Built-In 17:50:59 INFO - VRAM (Dynamic, Max): 1536 MB 17:50:59 INFO - Vendor: Intel (0x8086) 17:50:59 INFO - Device ID: 0x0a2e 17:50:59 INFO - Revision ID: 0x0009 17:50:59 INFO - Displays: 17:50:59 INFO - Display: 17:50:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:50:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:50:59 INFO - Display Serial Number: 1600x1200 60 17:50:59 INFO - Main Display: Yes 17:50:59 INFO - Mirror: Off 17:50:59 INFO - Online: Yes 17:50:59 INFO - Rotation: Supported 17:50:59 INFO - Return code: 0 17:50:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:50:59 INFO - Python 2.7.3 17:50:59 INFO - Return code: 0 17:50:59 INFO - grabbing minidump binary from tooltool 17:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:59 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 0x101f51d30>, '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 0x101d75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f48b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:50:59 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:50:59 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:50:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:50:59 INFO - Return code: 0 17:50:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:50:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:50:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:50:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:50:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:50:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:51:00 INFO - Return code: 0 17:51:00 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/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--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:51:00 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/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0054 --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:51:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YwAQ4mGgcq/Render', 17:51:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:51:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:51:00 INFO - 'HOME': '/Users/cltbld', 17:51:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:51:00 INFO - 'LOGNAME': 'cltbld', 17:51:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:51:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:00 INFO - 'MOZ_NO_REMOTE': '1', 17:51:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:51:00 INFO - 'NO_EM_RESTART': '1', 17:51:00 INFO - 'PAGER': '/bin/cat', 17:51:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:00 INFO - 'PWD': '/builds/slave/test', 17:51:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:51:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:51:00 INFO - 'SHELL': '/bin/bash', 17:51:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYJIDcjRTy/Listeners', 17:51:00 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 17:51:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:51:00 INFO - 'USER': 'cltbld', 17:51:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:51:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:00 INFO - 'XPC_FLAGS': '0x0', 17:51:00 INFO - 'XPC_SERVICE_NAME': '0', 17:51:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:51:00 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/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--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:51:00 INFO - mozversion application_buildid: 20160301162132 17:51:00 INFO - mozversion application_changeset: 2750be25944cafd09d3d793a4ecc33b11ae5f44b 17:51:00 INFO - mozversion application_display_name: Nightly 17:51:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:51:00 INFO - mozversion application_name: Firefox 17:51:00 INFO - mozversion application_remotingname: firefox 17:51:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:51:00 INFO - mozversion application_vendor: Mozilla 17:51:00 INFO - mozversion application_version: 47.0a1 17:51:00 INFO - mozversion platform_buildid: 20160301162132 17:51:00 INFO - mozversion platform_changeset: 2750be25944cafd09d3d793a4ecc33b11ae5f44b 17:51:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:51:00 INFO - mozversion platform_version: 47.0a1 17:51:00 INFO - using testdate: 1456883460 17:51:00 INFO - actual date: 1456883460 17:51:00 INFO - starting webserver on 'localhost:52184' 17:51:00 INFO - SUITE-START | Running 2 tests 17:51:00 INFO - TEST-START | dromaeo_css 17:51:00 INFO - operating with platform_type : mac_ 17:51:00 INFO - Initialising browser for dromaeo_css test... 17:51:00 INFO - TEST-INFO | started process 2309 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpbC7UA7/profile http://localhost:52184/getInfo.html) 17:51:03 INFO - PROCESS | 2309 | __metrics Screen width/height:1600/1200 17:51:03 INFO - PROCESS | 2309 | colorDepth:24 17:51:03 INFO - PROCESS | 2309 | Browser inner width/height: 1024/689 17:51:03 INFO - PROCESS | 2309 | __metrics 17:51:03 ERROR - PROCESS | 2309 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:51:04 INFO - TEST-INFO | 2309: exit 0 17:51:04 INFO - Browser initialized. 17:51:04 INFO - Running cycle 1/1 for dromaeo_css test... 17:51:04 INFO - TEST-INFO | started process 2313 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpbC7UA7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:51:16 INFO - PROCESS | 2313 | RSS: Main: 254029824 17:51:16 INFO - PROCESS | 2313 | 17:52:05 INFO - PROCESS | 2313 | 1456883525704 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:54:16 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:52184/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52184/tests/dromaeo/cssquery-ext.html) 17:54:17 INFO - PROCESS | 2313 | RSS: Main: 267927552 17:54:17 INFO - PROCESS | 2313 | 17:57:19 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:52184/tests/dromaeo/cssquery-ext.html (next: http://localhost:52184/tests/dromaeo/cssquery-jquery.html) 17:57:19 INFO - PROCESS | 2313 | RSS: Main: 280723456 17:57:19 INFO - PROCESS | 2313 | 18:00:21 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:52184/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52184/tests/dromaeo/cssquery-mootools.html) 18:00:22 INFO - PROCESS | 2313 | RSS: Main: 281624576 18:00:22 INFO - PROCESS | 2313 | 18:03:23 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:52184/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52184/tests/dromaeo/cssquery-prototype.html) 18:03:24 INFO - PROCESS | 2313 | RSS: Main: 282644480 18:03:24 INFO - PROCESS | 2313 | 18:06:27 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:52184/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52184/tests/dromaeo/cssquery-yui.html) 18:06:27 INFO - PROCESS | 2313 | RSS: Main: 286760960 18:06:27 INFO - PROCESS | 2313 | 18:09:29 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:52184/tests/dromaeo/cssquery-yui.html (next: http://localhost:52184/tests/dromaeo/cssquery-dojo.html) 18:09:30 INFO - PROCESS | 2313 | RSS: Main: 288514048 18:09:30 INFO - PROCESS | 2313 | 18:09:30 INFO - PROCESS | 2313 | __start_tp_report 18:09:30 INFO - PROCESS | 2313 | _x_x_mozilla_page_load 18:09:30 INFO - PROCESS | 2313 | _x_x_mozilla_page_load_details 18:09:30 INFO - PROCESS | 2313 | |i|pagename|runs| 18:09:30 INFO - PROCESS | 2313 | |0;dojo.html;3517.4899639552264;3524.665156810104;3558.6263442338536;3596.370635138852;3597;5314.920276195855;5726.484616384525;5837;5865.8826823463505;5895.145203945436;5763.769449222036;5824.504917082053;5825.650460972344;5885.49973252273;5963.761449542013;5132.358455193101;5204.063268611649;5320.467953204688;5365.839024829242;5387.164989426645;5284.44513326101;5300.469953004688;5303.23103150043;5355.678659280456;5357.303550538424;4972.676776009584;5146.253793199984;5237.083510385667;5242.895142097175;5250.501202385767;5199.4800519948085;5201.193814958688;5226.55574276187;5230.058589453897;5258.1849813279005;4189.476315460567;4611.308303754464;5184.481551844785;5232.189010703347;5254.054270231357;4690.554397332248;5218.191180367011;5658.490735833753;5715.514181294553;5726.828195154152;6237.844053898643;6238.625682459022;6246.187995560594;6263.561550691454;6276.184096067527;4939.92590111145;5102;6157.722902469355;6249.9062514062325;6318.968405157991;5932.19915311436;5936.762529498858;5948.078047902582;5973.432523910222;5993.9400605993815;6275.96862015687;6295.496360291166;6316.463100636405;6319.46284565817;6323.051542268697;6130.049842274455;6139.584134579375;6183.598066125687;6238.563300568917;6260.780872669435;6144.187464697836;6182.319944806068;6253.187085678833;6259.78090766821;6262.3111457739615;6196.659183744847;6241.157443745036;6254.562180647402;6269.686515674198;6281.96859015702;6102.974033066861;6126.670355029888;6133.365267548864;6227.595206311666;6256.749730010749;4949.90100197994;4950.851474455772;4954.777035033432;4962.404511458576;4988.8752781180765;4455.309427038814;4465.26323156682;4478.865634030984;4501.122281155209;4526.275795872644;5743.282089738783;5768.307803063659;5903.881922361528;5910.4385083417865;5915.674637894871;6232.916877876173;6247.687615619201;6259.280182778948;6263.279722831932;6285.654289014056;5882.49998750111;5912.083627037816;5926.407359264039;5932.93207222704;5965.3139888912465;5357.357117145967;5405.324334458192;5440.238366628675;5478.479544443271;5505.614606977473;5197.922031169535;6332.398422149889;6388.840278992877;6415.550911436155;6425.903611445832;6107.037103281039;6178.505719542336;6240.344763799736;6241.3134555197985;6261.843453913689;6258.687065646791;6382.595828917631;6423.518236132215;6427.1002059710745;6437.388448097423;6215.316315205414;6258.687065646791;6262.686865656608;6265.060240963892;6278.372162783685;6170.9074363885475;6172.444479996821;6239.812805615657;6246.750129994931;6273.090401891792;4979.278004689372;6091.695415229309;6111.470193407107;6210.875782484415;6221.626702397871;6195.256569211723;6215.440610345091;6218.906716399348;6224.221972253468;6246.5002799775;5839.211706419579;6054.061620448838;6074.787382441594;6090.451859332681;6124.448799608057;6129.236538068469;6176.3514830943905;6188.938110618837;6193;6228.844278892882;6091.360407157362;6093.177421048102;6107.267127944498;6111.052786818051;6118.20463339763 18:09:30 INFO - PROCESS | 2313 | |1;ext.html;514.8378260847835;565.0027701107546;568.1846550200463;618.0975775367964;634.8920683483807;29381;37431;37477.25045499092;37509.81245093771;37692.86921392362;38229.61770382295;38685;38713;38768;38878.805605972004;9381.953090234556;9474.952625236898;9545.188658963996;9558.61765529378;9603.039696030412;9521.476318802463;9630.422174669508;9633.325667203299;9642.758931026745;9687.41875487473;9615.038496150364;9623.03769623039;9648.22814174868;9706;9714.22286217101;9464.621415143385;9498.667546635868;9533.332666713333;9582.712518624452;9644.951775241114;9573.664921727706;9645.37305075168;9712.660056897974;9730.41617502952;9737.902620973771;37633.24733505342;37804;37985.430218546746;38163.66427175036;38169.809150954345;2606.1139212667595;3075.630924289077;3127.890523831678;3478.7043101336417;3970.987398213466;26255.949762009688;26265.080722174822;26468.0736174233;26522.204333870013;27199.864000680067;2704.3644743485265;2707.241972247774;2727.2091093583035;2742.492638861817;2904.259413849476;379053;381331;381794;382231;382423;59885.70057149686;60064.39935600588;60360;60434;60496;62126.068108978405;62566.0615090774;62970.37029629645;67577;69264.6536767323;16175.352985880432;16491.34034638625;16547.586310342096;16553.25510352037;16565.83434165667;12219.389030548615;12505.874941250471;12647.810282845765;12713.809292860615;12765.872341276468;17344.566385840455;19611.509712257022;20258.898705506377;20405.285814996405;20579.382618521468;9064.54677266134;9367.672131475365;9393.342466027449;9403.871535415794;9405.200557952514;928.9581968811419;934.9813003740023;941.3269512298739;958.5399008475971;1052.3265110329396;22469.662955055686;28807.135785926457;28832;29064.12807615775;29868.40263194724;1017.97455063624;1026.6150193677372;1044.7753732947301;1044.8089178336702;1067.7117178361955;12438.81341779874;14641.926790366193;14726.705465890622;14785.852141478663;15003.32485038176;400772;509562;509654;516904;528754;56616.71691641598;56780;56853.71573142191;56979.43020569824;57333.14000289999;1343.54991077988;1381.4198036824357;1385.1758203868683;1409.7955796409462;1421.9075760075768;22487.662685060066;28617.427651446436;28898.422031559672;28968.275793105342;29291;48583.75708121437;48765.51234487752;48909.75545122252;49189;49413.25880111729;474904;477637;477770;478580;479753;33016.83491582623;33258;33425.49861752124;42282;43130.78434607807;41141.35434582703;41157.97105072397;41422.72175030402;41969.740907772815;42332.36501452542;32949.682012719226;34925.82537087298;35371.82314088516;35374.938751837486;35426.29147417089;27874.442511150068;32473.512897306086;34820.82589587137;35352.82323588469;35740.4638930411;33438.39498880717;34238;35142.82428587841;35658.82170589234;35960.64039359573;30526.236844079074;32228.67771322257;32348.35303293968;32463.350732984734;32476.51285230676;22359;23564.293071207892;23973.52052958966;24204;24607.630885537088 18:09:30 INFO - PROCESS | 2313 | |2;jquery.html;349.4967247164084;354.5302474221657;360.5169073441589;363.9053846000039;363.9890803275903;18707.251709931603;19435.611287774253;21152.682709759367;21354.786452135475;21406;19618.901905490453;19993.000349982514;20061.59876802467;20113.59772804543;20198;5824.184614154011;6112.113743507189;6120.571559990803;6129.877402451948;6146.969265153668;4277.422547956017;5933.673647949361;6358.777442789503;6661.63361015144;6664.433523150514;5778.7977420790285;6435.6138631682015;6546.541742078057;6601.834954126137;6621.73513059477;5437.809676661318;5705.201271821928;5708.857278568027;5712.001199370322;5722.084466485363;4825.697061793297;5390.272313237702;5431.266778984826;5449.972750136224;5455.099908515091;12769.936150319281;13284.800727988992;13336.666583335495;13532.458701651922;13651.931740341333;1743.790745110582;2228.420610641245;2294.4837411582425;2552.9150111202666;2729.6587926509187;8105.554194519299;9598.232141428669;9665.806683866354;9774.462404567746;10163.79672406555;1426.2155814302196;1704.7357659562788;1725.1201887037575;1765.285059550884;1769;113302.30046549308;113961;115003;115786.42106789412;119174;11106.500207490682;11257.380844053656;11277.54889804415;11312.321260724382;11435.885641143648;13633.113847599874;13659.248741319125;13693.794593081111;13707.109037912503;13719.794203086962;8395.916040839636;8408.453450525696;8552.315814734806;8622.09468005863;8657.783555411039;8629.741107766651;8637.395382323177;8666.393352465393;8716.86680731501;8746.825063498694;4358.084802191512;4468.932966005513;4491.797869095833;4523.592876641118;4530.818767249273;1759.8504127149336;1801.3875282404047;1822.298415110192;1866.636005978821;1890.5746207103566;890.2610833008588;958.3339578992533;971.4754032822339;973.5862258540234;995.5967833027636;18791.15439805212;19678.70481942772;19730.802691973182;19876.304329348404;19993.400197994084;923.930705197113;938.8497840345512;960.3277705606104;967.9128878400978;990.7374545745383;8685.522296273766;10783.13734901206;10887.83668244977;10903.236773425942;10934.56261749521;200455;200572;201670;201816;202137;114585.28122078175;114971.85028149778;116561;117986;118354.40822795831;842.7527259655744;986.1322036607739;996.4768496539375;999.205631522941;1003.0571263012745;12665.620031399072;17889.821101788817;17933;18455;19493.92783396927;35891;44450.77774611106;46894.76552617215;48243.517564825306;48727.5127248723;55480.16779748226;62273.44316392126;64216.67891660512;67794;68291.65854170697;7589.696412143452;7820.452568320163;8016.879746803919;8107.756767296991;8476.660933562589;11462.82805757931;13042.02184836122;13240.139390939943;13408.463661453823;13484.932575337061;7037.894431583428;10124.683791107109;11385.430728463709;11392.48733806964;11876.52493900269;11328.150388721044;11470.369129697612;11626.76746465083;11640.825387619361;11717.648470545897;11534.538618455168;11818.468168932246;11948.701282468008;11991.940040299743;12026.27842329463;8070.83858322842;8081.87877181831;8084.151164127918;8183.181681831769;8372.748817535483;8597.742067737978;10898.087750192155;11642.41787910618;11815.232009919328;11950.940245298718 18:09:30 INFO - PROCESS | 2313 | |3;mootools.html;1502.3690050178923;1511.1008949674942;1711.8459338659518;1839.319451802833;1841.4475657302805;7701.807454813633;8244.958775206116;8410.158984101587;8572.914270857298;8576;6513.8926382514965;7448.888266676005;7547.924520754791;8166.387520935924;8352.081271060179;2391.222852572912;2414.9999999999914;2417.625268083441;2420.4311986683115;2428.781409673129;2405.7594240575977;2412.264259400882;2436.6954130733657;2438.341647755114;2446.6085426331792;2414.4808866093786;2429.744876787938;2446.3639453742067;2452;2456.9017239310406;2417.2627348658652;2424.212131057405;2439.9512009759883;2441.2676197140877;2452.896196711487;2137.1985505435464;2399.676043734091;2413.2398294537165;2424.757524247561;2428.247243354548;8522.70170544028;8551.700690475804;8562.14378562145;8566.871496927552;8586.828263434696;5178.4562620924635;5253.763580638881;5286.207068939651;5334.0665383557725;5336.839894803162;3448.77582957107;3532.116970757311;3537.7877327360184;3560.1633616100194;3578.141246100917;1009.8232809258351;1025.600015993763;1030.0574973898874;1030.2015937648307;1034.886162522122;10934.781304373868;10962.397068161248;11120.499577519031;11237;11240.49417776202;4646.372739680168;4753.31076993834;4768.809247630125;4770.475247722748;4818.831340903052;9492.667756628485;9524.333296669167;9574.856377154349;9601.32790704644;9605.951970240105;4745.549172828576;5102.005109003783;5167.870803229949;5189.169732842727;5281.9207711884355;4034.5561988181275;4314.7626880521875;4645.976770116128;4758.738269395148;4796.136695394863;3616.8553257869917;3702.2965636528975;3706.981465092711;3713.9442908356395;3716.0338312039066;1283.5828355784408;1284.389914790467;1291.9160254583421;1295.086963690596;1298.3702904091508;1029.5212726082407;1040.2354269611828;1045.696747943088;1166.4750862112085;1320.0165876422127;7842.803929901798;7892.960535197287;7920.722774702857;7979.84040319202;8021.7994550135545;1182.6097387861985;1184.5617121665039;1195.8505186851644;1224.989383758403;1232.0882546915218;6239.968800156061;6255.843603909848;6274;6294.653794041372;6309.526785491106;9184.49485278316;9192.17270445663;9517.191038761644;9532.714018579454;9540.952295238618;9198.862017069749;9361.204297634642;9420.963693993655;9441.339106262632;9489.952550237205;7933.682652693943;8016.599170041474;8131.064927533291;8172.509649421054;8242.17578242171;7652.693892244248;7659.234076592296;7701.961490192513;7738.148803631709;7753.10839253493;9180.540972951192;9290.256779457492;9413.29400294967;9457.959624441444;9586.520673966414;9324.254059675073;9621.711348659552;9648.324617277003;9716.076972687584;9737.561809718438;6247.3440288769025;6555.246146693001;6737.797866064026;6766.661666916733;6863.759768408082;7821.648025838965;7912.090109637235;7932.6430310637315;7935.166807485131;7968.7609371718945;6987.6855541499735;7121.181064177686;7123.465740069619;7194.820129496805;7269.7455589054125;6963.895541566779;6989.1962424321855;7070.151581810215;7117.145942486728;7122.964385178041;7442.144153422426;7545;7564.962175189089;7616.124145723313;7618.961905190438;6771.593704377753;6775.762848300285;6828.931710682829;6837.418819400406;6867.896981545381;6940.479464040116;6972.58164510131;7008.194057683431;7013.403860671696;7018.122734658168 18:09:30 INFO - PROCESS | 2313 | |4;prototype.html;322.89021732610917;326.11785121247016;327.95736554247947;331.1324330254733;334.2746240657773;6797.218319893208;6826.385625293723;6850.725970961162;6859.10831591893;6870.519063665545;6640.269570347258;6713;6749.763758268462;6760.053592497042;6803.625800580966;4711.175544279755;4820.783064762094;4926.694425977101;4964.776585053682;4981.501849815017;4925.82759603414;4943.901121977558;4945.134601444751;4955.05853887762;4958.107540642683;4882.438519570242;4885.218365061591;4885.682430642015;4921.557059864629;4938.061768264036;4885.609151267908;4891.608671306305;4895.36360273164;4912.70523768575;4918.606511479073;4179.498460184797;4185;4186.016286172747;4199.181159673864;4209.810558524874;5836.358000619928;5870.823875283706;6256.624602523863;6462.48300135988;6482.93517064828;5878.882422351529;5911.763529458816;5912.379200183962;5919.5264378850015;5936.584439089265;5805.564582656318;7299.306565876233;7304.415646748247;7323.816904577375;7326.96336518314;4732.95267047332;4740.07568524138;4752.833650822239;4756.905911640308;4762.738049407281;7625.23747625233;7736.303732664087;7738.419618528576;7758.79738640506;7778.338841198505;4597.356370108188;4791.257355109963;4805.711657300573;4816.446108697474;4868.318435419044;4841.515848415131;4876.975615121973;4881.926771098437;4897.2654101885;4901.387326584177;5773.480386765212;5885.852853678693;5890.293164820249;5905.881882362329;5919.585629006015;7330.157031941395;7348.926510734931;7368.19479227582;7377.81555461107;7386.4829461938225;1713.5116491799777;1740.1908112727642;1741.5907261793468;1742.7821522309712;1746.5982823950308;867.2584939876315;1079.3362082319318;1106.5131342209402;1113.0427832064418;1128.1877048525048;5180.844574662766;5396.64921780083;5707.544576133142;6500.577462464925;6732.764353247613;7586.127595326498;7606.201348858401;7613;7615.010048693634;7629.809254768676;6511.479081673549;6609.6364699941005;6826.283240259801;6834.521583489108;6852.349026842442;4052.412400202013;4079.6940229482907;4082.4692789937117;4088.570700076449;4088.8160032798596;7992.920070799218;8012.71955481567;8025.598720063974;8034.504990329226;8069.072056713436;7202.92797072033;7277.526960747535;7667.693292268358;7942.722004729807;7978.760637180778;8006.479578827474;8014.559199243981;8033.799155021171;8059.234372734581;8062.39532035088;7733.651985660771;7735.806604834924;7742.883856742041;7753.37972962173;7785.883211751941;6152.354002829638;7559.659815308214;7579.204183560647;7596.734114305973;7603.771886843404;5443.564514838724;7210.387117095106;8005.319547838499;8012.118666946515;8016.152246921394;4354.085642015086;4595.747233902168;4624.190766615761;4656.557627025427;4669.463011753692;6814;7590.696372145052;7621.923780762121;7644.617769111634;7650.846983060419;6084.60450070744;7258.419326453976;7362.742304019548;7370.520916140434;7372.41020718352;5605.243292155506;7327.816804579928;7340.449466289942;7369.410447164107;7416.851662966603;7184.353408193078;7208.495405321577;7212.639368031682;7215.350618444365;7238.782836514913;7394.075740532434;7410.147832999274;7424.888626670712;7426.257374262746;7449.478536502393;6258.749650013949;6869.965650171717;7231.566106033655;7244;7244.333803225182 18:09:30 INFO - PROCESS | 2313 | |5;yui.html;688.8277930517371;727.4980263618103;739.9334059934605;752.1650967426156;758.2796343473698;14511.709765804677;14849.851501484982;15038.473653422132;15073.849261507381;15098.849011509881;14068.437262509513;14079.944004199675;14117.152970821759;14136.646583835409;14139.36372863221;732.1360794262768;870.4037734152126;878.7890906182502;898.5148020069188;900.7748062984253;892.0321451225428;894.785251539629;896.9775755606097;898.8516894712365;900.2033200617435;946.2146418472652;948.4025064209538;949.3070058857004;950.0831697411996;950.3157726436955;875.4528419737663;887.2857349833381;889.204162274767;904.3443503459972;937.7186843946823;651.9608823470606;656.4682607088274;684.2780866186172;689.3382352941182;701.7263267325696;14755.40978360875;14939.626509337244;14939.70120597582;14978.775318370124;15027.699446011127;12587.992960563133;12619.684507887285;12685.112042157052;12827.294498802563;12905.612831615066;9884.65403710874;10089.445080520569;10089.495525223709;10108.292419530635;10392.272540922138;3463.307338532278;3496.318217947501;3498.807565583892;3506.6318036606044;3584.9641503585153;82337;83349;84567.15432845654;84591.57704211501;84750.57624711898;8101.918980810235;9386.108319709616;9441.858372124423;9545.140937315675;9947.452890091114;21870.671939920914;21893.890530547244;21906.78093219079;21952;21969.011394487286;7103.680334384965;7278.308560686726;7349.853002939912;7435.442341824385;7680.270374314431;3959.3467077932396;3967.2858885400906;4014.217227640582;4015.297322968469;4053.4527838741983;3478.4956181353564;3506.631803660579;3523.5419395478934;3531.2760884018717;3551.1654761131113;612.9693515324306;613.910982907476;613.9899864722506;628.2021832272987;629.7764293675771;472.0605994071841;498.94761050089215;547.6036107924855;582.9854253643608;611.9632822030692;7952.721654742057;8001.479903806234;8097.433179677366;8110.878336824952;8232.306196551552;496.76900241387204;523.4007061914087;571.6770024935898;602.6233603997501;625.2376742738936;2933.3545823082327;3833.926500579842;3913.92172156561;3951.940720889189;3952.822123004414;50782;86620.56689716637;86766.56616716876;87406;87549;76814.61592692001;77018.61490692623;77075;77508;78084;61377.07934380988;66105;66536;67372.66313668498;67644.6617766908;7750.806229844299;7809.726659566888;7949.642266097924;8007;8089.8382032360205;42309.57690423179;46321;46552.76723616496;49860.75069624629;50463.99072018613;61693.691531542056;63053;65846;68912.3108768906;70421.29578704147;10298.605976089542;10531.89468105309;10786.406747628957;10912.236143469881;11063.114950803756;11592.880416185348;11646.650600481998;11715.531378744754;11910.761784764083;12255.365096504294;10956.178286628376;11010.559577616805;11310;11452.14108941816;11759.000484958533;11082.722931926766;11095.72260693489;11133.387663678575;11177.66467005991;11508.194426390073;10451.529681164213;10970.725731856768;10985.890141098487;11141.83287250708;11349.48927298257;9127;9299.809954796046;9371.531423428938;9395.906040939502;9513.809723805623;7182.75658769091;9201.125893040151;9445.291603129655;9445.763855903382;9707.563159657973 18:09:30 INFO - PROCESS | 2313 | __end_tp_report 18:09:30 INFO - PROCESS | 2313 | __start_cc_report 18:09:30 INFO - PROCESS | 2313 | _x_x_mozilla_cycle_collect,348 18:09:30 INFO - PROCESS | 2313 | __end_cc_report 18:09:30 INFO - PROCESS | 2313 | __startTimestamp1456884570241__endTimestamp 18:09:30 INFO - PROCESS | 2313 | 18:09:30 INFO - PROCESS | 2313 | ------- Summary: start ------- 18:09:30 INFO - PROCESS | 2313 | Number of tests: 6 18:09:30 INFO - PROCESS | 2313 | 18:09:30 INFO - PROCESS | 2313 | [#0] dojo.html Cycles:165 Average:5761.54 Median:6090.45 stddev:651.32 (10.7%) stddev-sans-first:629.08 18:09:30 INFO - PROCESS | 2313 | Values: 3517.5 3524.7 3558.6 3596.4 3597.0 5314.9 5726.5 5837.0 5865.9 5895.1 5763.8 5824.5 5825.7 5885.5 5963.8 5132.4 5204.1 5320.5 5365.8 5387.2 5284.4 5300.5 5303.2 5355.7 5357.3 4972.7 5146.3 5237.1 5242.9 5250.5 5199.5 5201.2 5226.6 5230.1 5258.2 4189.5 4611.3 5184.5 5232.2 5254.1 4690.6 5218.2 5658.5 5715.5 5726.8 6237.8 6238.6 6246.2 6263.6 6276.2 4939.9 5102.0 6157.7 6249.9 6319.0 5932.2 5936.8 5948.1 5973.4 5993.9 6276.0 6295.5 6316.5 6319.5 6323.1 6130.0 6139.6 6183.6 6238.6 6260.8 6144.2 6182.3 6253.2 6259.8 6262.3 6196.7 6241.2 6254.6 6269.7 6282.0 6103.0 6126.7 6133.4 6227.6 6256.7 4949.9 4950.9 4954.8 4962.4 4988.9 4455.3 4465.3 4478.9 4501.1 4526.3 5743.3 5768.3 5903.9 5910.4 5915.7 6232.9 6247.7 6259.3 6263.3 6285.7 5882.5 5912.1 5926.4 5932.9 5965.3 5357.4 5405.3 5440.2 5478.5 5505.6 5197.9 6332.4 6388.8 6415.6 6425.9 6107.0 6178.5 6240.3 6241.3 6261.8 6258.7 6382.6 6423.5 6427.1 6437.4 6215.3 6258.7 6262.7 6265.1 6278.4 6170.9 6172.4 6239.8 6246.8 6273.1 4979.3 6091.7 6111.5 6210.9 6221.6 6195.3 6215.4 6218.9 6224.2 6246.5 5839.2 6054.1 6074.8 6090.5 6124.4 6129.2 6176.4 6188.9 6193.0 6228.8 6091.4 6093.2 6107.3 6111.1 6118.2 18:09:30 INFO - PROCESS | 2313 | 18:09:30 INFO - PROCESS | 2313 | [#1] ext.html Cycles:180 Average:59595.00 Median:208519.22 stddev:120636.15 (57.9%) stddev-sans-first:120893.02 18:09:30 INFO - PROCESS | 2313 | Values: 514.8 565.0 568.2 618.1 634.9 29381.0 37431.0 37477.3 37509.8 37692.9 38229.6 38685.0 38713.0 38768.0 38878.8 9382.0 9475.0 9545.2 9558.6 9603.0 9521.5 9630.4 9633.3 9642.8 9687.4 9615.0 9623.0 9648.2 9706.0 9714.2 9464.6 9498.7 9533.3 9582.7 9645.0 9573.7 9645.4 9712.7 9730.4 9737.9 37633.2 37804.0 37985.4 38163.7 38169.8 2606.1 3075.6 3127.9 3478.7 3971.0 26255.9 26265.1 26468.1 26522.2 27199.9 2704.4 2707.2 2727.2 2742.5 2904.3 379053.0 381331.0 381794.0 382231.0 382423.0 59885.7 60064.4 60360.0 60434.0 60496.0 62126.1 62566.1 62970.4 67577.0 69264.7 16175.4 16491.3 16547.6 16553.3 16565.8 12219.4 12505.9 12647.8 12713.8 12765.9 17344.6 19611.5 20258.9 20405.3 20579.4 9064.5 9367.7 9393.3 9403.9 9405.2 929.0 935.0 941.3 958.5 1052.3 22469.7 28807.1 28832.0 29064.1 29868.4 1018.0 1026.6 1044.8 1044.8 1067.7 12438.8 14641.9 14726.7 14785.9 15003.3 400772.0 509562.0 509654.0 516904.0 528754.0 56616.7 56780.0 56853.7 56979.4 57333.1 1343.5 1381.4 1385.2 1409.8 1421.9 22487.7 28617.4 28898.4 28968.3 29291.0 48583.8 48765.5 48909.8 49189.0 49413.3 474904.0 477637.0 477770.0 478580.0 479753.0 33016.8 33258.0 33425.5 42282.0 43130.8 41141.4 41158.0 41422.7 41969.7 42332.4 32949.7 34925.8 35371.8 35374.9 35426.3 27874.4 32473.5 34820.8 35352.8 35740.5 33438.4 34238.0 35142.8 35658.8 35960.6 30526.2 32228.7 32348.4 32463.4 32476.5 22359.0 23564.3 23973.5 24204.0 24607.6 18:09:30 INFO - PROCESS | 2313 | 18:09:30 INFO - PROCESS | 2313 | [#2] jquery.html Cycles:180 Average:22533.48 Median:2261.45 stddev:40465.79 (1789.4%) stddev-sans-first:40545.03 18:09:30 INFO - PROCESS | 2313 | Values: 349.5 354.5 360.5 363.9 364.0 18707.3 19435.6 21152.7 21354.8 21406.0 19618.9 19993.0 20061.6 20113.6 20198.0 5824.2 6112.1 6120.6 6129.9 6147.0 4277.4 5933.7 6358.8 6661.6 6664.4 5778.8 6435.6 6546.5 6601.8 6621.7 5437.8 5705.2 5708.9 5712.0 5722.1 4825.7 5390.3 5431.3 5450.0 5455.1 12769.9 13284.8 13336.7 13532.5 13651.9 1743.8 2228.4 2294.5 2552.9 2729.7 8105.6 9598.2 9665.8 9774.5 10163.8 1426.2 1704.7 1725.1 1765.3 1769.0 113302.3 113961.0 115003.0 115786.4 119174.0 11106.5 11257.4 11277.5 11312.3 11435.9 13633.1 13659.2 13693.8 13707.1 13719.8 8395.9 8408.5 8552.3 8622.1 8657.8 8629.7 8637.4 8666.4 8716.9 8746.8 4358.1 4468.9 4491.8 4523.6 4530.8 1759.9 1801.4 1822.3 1866.6 1890.6 890.3 958.3 971.5 973.6 995.6 18791.2 19678.7 19730.8 19876.3 19993.4 923.9 938.8 960.3 967.9 990.7 8685.5 10783.1 10887.8 10903.2 10934.6 200455.0 200572.0 201670.0 201816.0 202137.0 114585.3 114971.9 116561.0 117986.0 118354.4 842.8 986.1 996.5 999.2 1003.1 12665.6 17889.8 17933.0 18455.0 19493.9 35891.0 44450.8 46894.8 48243.5 48727.5 55480.2 62273.4 64216.7 67794.0 68291.7 7589.7 7820.5 8016.9 8107.8 8476.7 11462.8 13042.0 13240.1 13408.5 13484.9 7037.9 10124.7 11385.4 11392.5 11876.5 11328.2 11470.4 11626.8 11640.8 11717.6 11534.5 11818.5 11948.7 11991.9 12026.3 8070.8 8081.9 8084.2 8183.2 8372.7 8597.7 10898.1 11642.4 11815.2 11950.9 18:09:30 INFO - PROCESS | 2313 | 18:09:30 INFO - PROCESS | 2313 | [#3] mootools.html Cycles:180 Average:5785.18 Median:6411.71 stddev:2964.32 (46.2%) stddev-sans-first:2955.16 18:09:30 INFO - PROCESS | 2313 | Values: 1502.4 1511.1 1711.8 1839.3 1841.4 7701.8 8245.0 8410.2 8572.9 8576.0 6513.9 7448.9 7547.9 8166.4 8352.1 2391.2 2415.0 2417.6 2420.4 2428.8 2405.8 2412.3 2436.7 2438.3 2446.6 2414.5 2429.7 2446.4 2452.0 2456.9 2417.3 2424.2 2440.0 2441.3 2452.9 2137.2 2399.7 2413.2 2424.8 2428.2 8522.7 8551.7 8562.1 8566.9 8586.8 5178.5 5253.8 5286.2 5334.1 5336.8 3448.8 3532.1 3537.8 3560.2 3578.1 1009.8 1025.6 1030.1 1030.2 1034.9 10934.8 10962.4 11120.5 11237.0 11240.5 4646.4 4753.3 4768.8 4770.5 4818.8 9492.7 9524.3 9574.9 9601.3 9606.0 4745.5 5102.0 5167.9 5189.2 5281.9 4034.6 4314.8 4646.0 4758.7 4796.1 3616.9 3702.3 3707.0 3713.9 3716.0 1283.6 1284.4 1291.9 1295.1 1298.4 1029.5 1040.2 1045.7 1166.5 1320.0 7842.8 7893.0 7920.7 7979.8 8021.8 1182.6 1184.6 1195.9 1225.0 1232.1 6240.0 6255.8 6274.0 6294.7 6309.5 9184.5 9192.2 9517.2 9532.7 9541.0 9198.9 9361.2 9421.0 9441.3 9490.0 7933.7 8016.6 8131.1 8172.5 8242.2 7652.7 7659.2 7702.0 7738.1 7753.1 9180.5 9290.3 9413.3 9458.0 9586.5 9324.3 9621.7 9648.3 9716.1 9737.6 6247.3 6555.2 6737.8 6766.7 6863.8 7821.6 7912.1 7932.6 7935.2 7968.8 6987.7 7121.2 7123.5 7194.8 7269.7 6963.9 6989.2 7070.2 7117.1 7123.0 7442.1 7545.0 7565.0 7616.1 7619.0 6771.6 6775.8 6828.9 6837.4 6867.9 6940.5 6972.6 7008.2 7013.4 7018.1 18:09:30 INFO - PROCESS | 2313 | 18:09:30 INFO - PROCESS | 2313 | [#4] prototype.html Cycles:180 Average:5920.15 Median:6624.95 stddev:1923.04 (29.0%) stddev-sans-first:1881.99 18:09:30 INFO - PROCESS | 2313 | Values: 322.9 326.1 328.0 331.1 334.3 6797.2 6826.4 6850.7 6859.1 6870.5 6640.3 6713.0 6749.8 6760.1 6803.6 4711.2 4820.8 4926.7 4964.8 4981.5 4925.8 4943.9 4945.1 4955.1 4958.1 4882.4 4885.2 4885.7 4921.6 4938.1 4885.6 4891.6 4895.4 4912.7 4918.6 4179.5 4185.0 4186.0 4199.2 4209.8 5836.4 5870.8 6256.6 6462.5 6482.9 5878.9 5911.8 5912.4 5919.5 5936.6 5805.6 7299.3 7304.4 7323.8 7327.0 4733.0 4740.1 4752.8 4756.9 4762.7 7625.2 7736.3 7738.4 7758.8 7778.3 4597.4 4791.3 4805.7 4816.4 4868.3 4841.5 4877.0 4881.9 4897.3 4901.4 5773.5 5885.9 5890.3 5905.9 5919.6 7330.2 7348.9 7368.2 7377.8 7386.5 1713.5 1740.2 1741.6 1742.8 1746.6 867.3 1079.3 1106.5 1113.0 1128.2 5180.8 5396.6 5707.5 6500.6 6732.8 7586.1 7606.2 7613.0 7615.0 7629.8 6511.5 6609.6 6826.3 6834.5 6852.3 4052.4 4079.7 4082.5 4088.6 4088.8 7992.9 8012.7 8025.6 8034.5 8069.1 7202.9 7277.5 7667.7 7942.7 7978.8 8006.5 8014.6 8033.8 8059.2 8062.4 7733.7 7735.8 7742.9 7753.4 7785.9 6152.4 7559.7 7579.2 7596.7 7603.8 5443.6 7210.4 8005.3 8012.1 8016.2 4354.1 4595.7 4624.2 4656.6 4669.5 6814.0 7590.7 7621.9 7644.6 7650.8 6084.6 7258.4 7362.7 7370.5 7372.4 5605.2 7327.8 7340.4 7369.4 7416.9 7184.4 7208.5 7212.6 7215.4 7238.8 7394.1 7410.1 7424.9 7426.3 7449.5 6258.7 6870.0 7231.6 7244.0 7244.3 18:09:30 INFO - PROCESS | 2313 | 18:09:30 INFO - PROCESS | 2313 | [#5] yui.html Cycles:180 Average:17698.38 Median:613.95 stddev:24659.20 (4016.5%) stddev-sans-first:24695.30 18:09:30 INFO - PROCESS | 2313 | Values: 688.8 727.5 739.9 752.2 758.3 14511.7 14849.9 15038.5 15073.8 15098.8 14068.4 14079.9 14117.2 14136.6 14139.4 732.1 870.4 878.8 898.5 900.8 892.0 894.8 897.0 898.9 900.2 946.2 948.4 949.3 950.1 950.3 875.5 887.3 889.2 904.3 937.7 652.0 656.5 684.3 689.3 701.7 14755.4 14939.6 14939.7 14978.8 15027.7 12588.0 12619.7 12685.1 12827.3 12905.6 9884.7 10089.4 10089.5 10108.3 10392.3 3463.3 3496.3 3498.8 3506.6 3585.0 82337.0 83349.0 84567.2 84591.6 84750.6 8101.9 9386.1 9441.9 9545.1 9947.5 21870.7 21893.9 21906.8 21952.0 21969.0 7103.7 7278.3 7349.9 7435.4 7680.3 3959.3 3967.3 4014.2 4015.3 4053.5 3478.5 3506.6 3523.5 3531.3 3551.2 613.0 613.9 614.0 628.2 629.8 472.1 498.9 547.6 583.0 612.0 7952.7 8001.5 8097.4 8110.9 8232.3 496.8 523.4 571.7 602.6 625.2 2933.4 3833.9 3913.9 3951.9 3952.8 50782.0 86620.6 86766.6 87406.0 87549.0 76814.6 77018.6 77075.0 77508.0 78084.0 61377.1 66105.0 66536.0 67372.7 67644.7 7750.8 7809.7 7949.6 8007.0 8089.8 42309.6 46321.0 46552.8 49860.8 50464.0 61693.7 63053.0 65846.0 68912.3 70421.3 10298.6 10531.9 10786.4 10912.2 11063.1 11592.9 11646.7 11715.5 11910.8 12255.4 10956.2 11010.6 11310.0 11452.1 11759.0 11082.7 11095.7 11133.4 11177.7 11508.2 10451.5 10970.7 10985.9 11141.8 11349.5 9127.0 9299.8 9371.5 9395.9 9513.8 7182.8 9201.1 9445.3 9445.8 9707.6 18:09:30 INFO - PROCESS | 2313 | -------- Summary: end -------- 18:09:30 INFO - PROCESS | 2313 | 18:09:30 INFO - TEST-INFO | 2313: exit 0 18:09:30 INFO - TEST-OK | dromaeo_css | took 1110154ms 18:09:30 INFO - TEST-START | kraken 18:09:30 INFO - operating with platform_type : mac_ 18:09:30 INFO - Initialising browser for kraken test... 18:09:30 INFO - TEST-INFO | started process 2317 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpTpPdW5/profile http://localhost:52184/getInfo.html) 18:09:33 INFO - PROCESS | 2317 | __metrics Screen width/height:1600/1200 18:09:33 INFO - PROCESS | 2317 | colorDepth:24 18:09:33 INFO - PROCESS | 2317 | Browser inner width/height: 1024/689 18:09:33 INFO - PROCESS | 2317 | __metrics 18:09:33 ERROR - PROCESS | 2317 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 18:09:34 INFO - TEST-INFO | 2317: exit 0 18:09:34 INFO - Browser initialized. 18:09:34 INFO - Running cycle 1/1 for kraken test... 18:09:34 INFO - TEST-INFO | started process 2320 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpTpPdW5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:09:46 INFO - PROCESS | 2320 | RSS: Main: 254013440 18:09:46 INFO - PROCESS | 2320 | 18:09:48 INFO - PROCESS | 2320 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52184/tests/kraken/driver.html?testName=audio-beat-detection) 18:09:49 INFO - PROCESS | 2320 | RSS: Main: 267874304 18:09:49 INFO - PROCESS | 2320 | 18:09:52 INFO - PROCESS | 2320 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52184/tests/kraken/driver.html?testName=audio-dft) 18:09:52 INFO - PROCESS | 2320 | RSS: Main: 276897792 18:09:52 INFO - PROCESS | 2320 | 18:09:56 INFO - PROCESS | 2320 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52184/tests/kraken/driver.html?testName=audio-fft) 18:09:56 INFO - PROCESS | 2320 | RSS: Main: 279203840 18:09:56 INFO - PROCESS | 2320 | 18:09:58 INFO - PROCESS | 2320 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52184/tests/kraken/driver.html?testName=audio-oscillator) 18:09:59 INFO - PROCESS | 2320 | RSS: Main: 281387008 18:09:59 INFO - PROCESS | 2320 | 18:10:01 INFO - PROCESS | 2320 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52184/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:10:01 INFO - PROCESS | 2320 | RSS: Main: 281415680 18:10:01 INFO - PROCESS | 2320 | 18:10:04 INFO - PROCESS | 2320 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52184/tests/kraken/driver.html?testName=imaging-darkroom) 18:10:05 INFO - PROCESS | 2320 | RSS: Main: 283152384 18:10:05 INFO - PROCESS | 2320 | 18:10:07 INFO - PROCESS | 2320 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52184/tests/kraken/driver.html?testName=imaging-desaturate) 18:10:08 INFO - PROCESS | 2320 | RSS: Main: 283074560 18:10:08 INFO - PROCESS | 2320 | 18:10:11 INFO - PROCESS | 2320 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52184/tests/kraken/driver.html?testName=json-parse-financial) 18:10:12 INFO - PROCESS | 2320 | RSS: Main: 283803648 18:10:12 INFO - PROCESS | 2320 | 18:10:13 INFO - PROCESS | 2320 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52184/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:10:14 INFO - PROCESS | 2320 | RSS: Main: 283435008 18:10:14 INFO - PROCESS | 2320 | 18:10:16 INFO - PROCESS | 2320 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:10:16 INFO - PROCESS | 2320 | RSS: Main: 282636288 18:10:16 INFO - PROCESS | 2320 | 18:10:18 INFO - PROCESS | 2320 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:10:19 INFO - PROCESS | 2320 | RSS: Main: 282234880 18:10:19 INFO - PROCESS | 2320 | 18:10:21 INFO - PROCESS | 2320 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:10:22 INFO - PROCESS | 2320 | RSS: Main: 282304512 18:10:22 INFO - PROCESS | 2320 | 18:10:25 INFO - PROCESS | 2320 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:10:25 INFO - PROCESS | 2320 | RSS: Main: 284434432 18:10:25 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | Cycle 1(1): loaded http://localhost:52184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52184/tests/kraken/driver.html?testName=ai-astar) 18:10:27 INFO - PROCESS | 2320 | RSS: Main: 285458432 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | __start_tp_report 18:10:27 INFO - PROCESS | 2320 | _x_x_mozilla_page_load 18:10:27 INFO - PROCESS | 2320 | _x_x_mozilla_page_load_details 18:10:27 INFO - PROCESS | 2320 | |i|pagename|runs| 18:10:27 INFO - PROCESS | 2320 | |0;ai-astar;115;105;114;115;116;124;114;115;112;113 18:10:27 INFO - PROCESS | 2320 | |1;audio-beat-detection;153;123;147;155;121;146;149;148;165;122 18:10:27 INFO - PROCESS | 2320 | |2;audio-dft;196;198;201;202;205;229;268;276;227;195 18:10:27 INFO - PROCESS | 2320 | |3;audio-fft;69;75;70;124;57;57;56;58;121;51 18:10:27 INFO - PROCESS | 2320 | |4;audio-oscillator;84;86;132;77;79;81;119;78;81;117 18:10:27 INFO - PROCESS | 2320 | |5;imaging-gaussian-blur;89;85;89;88;102;86;89;86;88;85 18:10:27 INFO - PROCESS | 2320 | |6;imaging-darkroom;95;95;96;94;116;136;95;103;95;94 18:10:27 INFO - PROCESS | 2320 | |7;imaging-desaturate;92;94;94;91;94;95;145;154;93;92 18:10:27 INFO - PROCESS | 2320 | |8;json-parse-financial;57;55;61;55;55;57;55;64;58;55 18:10:27 INFO - PROCESS | 2320 | |9;json-stringify-tinderbox;66;68;70;67;73;72;70;67;67;71 18:10:27 INFO - PROCESS | 2320 | |10;stanford-crypto-aes;87;84;83;83;87;84;86;85;85;85 18:10:27 INFO - PROCESS | 2320 | |11;stanford-crypto-ccm;141;116;136;141;132;124;134;131;122;132 18:10:27 INFO - PROCESS | 2320 | |12;stanford-crypto-pbkdf2;182;147;139;139;143;140;185;138;138;129 18:10:27 INFO - PROCESS | 2320 | |13;stanford-crypto-sha256-iterative;70;67;71;66;66;59;56;60;75;89 18:10:27 INFO - PROCESS | 2320 | __end_tp_report 18:10:27 INFO - PROCESS | 2320 | __start_cc_report 18:10:27 INFO - PROCESS | 2320 | _x_x_mozilla_cycle_collect,869 18:10:27 INFO - PROCESS | 2320 | __end_cc_report 18:10:27 INFO - PROCESS | 2320 | __startTimestamp1456884627683__endTimestamp 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | ------- Summary: start ------- 18:10:27 INFO - PROCESS | 2320 | Number of tests: 14 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:4.62 (4.0%) stddev-sans-first:4.89 18:10:27 INFO - PROCESS | 2320 | Values: 115.0 105.0 114.0 115.0 116.0 124.0 114.0 115.0 112.0 113.0 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:148.50 stddev:15.42 (10.4%) stddev-sans-first:15.91 18:10:27 INFO - PROCESS | 2320 | Values: 153.0 123.0 147.0 155.0 121.0 146.0 149.0 148.0 165.0 122.0 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | [#2] audio-dft Cycles:10 Average:219.70 Median:216.00 stddev:30.12 (13.9%) stddev-sans-first:30.70 18:10:27 INFO - PROCESS | 2320 | Values: 196.0 198.0 201.0 202.0 205.0 229.0 268.0 276.0 227.0 195.0 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | [#3] audio-fft Cycles:10 Average:73.80 Median:57.50 stddev:26.74 (46.5%) stddev-sans-first:28.31 18:10:27 INFO - PROCESS | 2320 | Values: 69.0 75.0 70.0 124.0 57.0 57.0 56.0 58.0 121.0 51.0 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:80.00 stddev:20.73 (25.9%) stddev-sans-first:21.70 18:10:27 INFO - PROCESS | 2320 | Values: 84.0 86.0 132.0 77.0 79.0 81.0 119.0 78.0 81.0 117.0 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:88.00 stddev:4.95 (5.6%) stddev-sans-first:5.24 18:10:27 INFO - PROCESS | 2320 | Values: 89.0 85.0 89.0 88.0 102.0 86.0 89.0 86.0 88.0 85.0 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | [#6] imaging-darkroom Cycles:10 Average:101.90 Median:95.00 stddev:13.80 (14.5%) stddev-sans-first:14.40 18:10:27 INFO - PROCESS | 2320 | Values: 95.0 95.0 96.0 94.0 116.0 136.0 95.0 103.0 95.0 94.0 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | [#7] imaging-desaturate Cycles:10 Average:104.40 Median:93.50 stddev:23.89 (25.6%) stddev-sans-first:24.92 18:10:27 INFO - PROCESS | 2320 | Values: 92.0 94.0 94.0 91.0 94.0 95.0 145.0 154.0 93.0 92.0 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:3.08 (5.4%) stddev-sans-first:3.27 18:10:27 INFO - PROCESS | 2320 | Values: 57.0 55.0 61.0 55.0 55.0 57.0 55.0 64.0 58.0 55.0 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:70.00 stddev:2.42 (3.5%) stddev-sans-first:2.30 18:10:27 INFO - PROCESS | 2320 | Values: 66.0 68.0 70.0 67.0 73.0 72.0 70.0 67.0 67.0 71.0 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:1.45 (1.7%) stddev-sans-first:1.32 18:10:27 INFO - PROCESS | 2320 | Values: 87.0 84.0 83.0 83.0 87.0 84.0 86.0 85.0 85.0 85.0 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:133.00 stddev:8.10 (6.1%) stddev-sans-first:7.73 18:10:27 INFO - PROCESS | 2320 | Values: 141.0 116.0 136.0 141.0 132.0 124.0 134.0 131.0 122.0 132.0 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:141.50 stddev:19.26 (13.6%) stddev-sans-first:16.02 18:10:27 INFO - PROCESS | 2320 | Values: 182.0 147.0 139.0 139.0 143.0 140.0 185.0 138.0 138.0 129.0 18:10:27 INFO - PROCESS | 2320 | 18:10:27 INFO - PROCESS | 2320 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:9.43 (13.8%) stddev-sans-first:9.97 18:10:27 INFO - PROCESS | 2320 | Values: 70.0 67.0 71.0 66.0 66.0 59.0 56.0 60.0 75.0 89.0 18:10:27 INFO - PROCESS | 2320 | -------- Summary: end -------- 18:10:27 INFO - PROCESS | 2320 | 18:10:28 INFO - TEST-INFO | 2320: exit 0 18:10:28 INFO - TEST-OK | kraken | took 57775ms 18:10:28 INFO - SUITE-END | took 1167s 18:10:28 INFO - Completed test suite (00:19:28) 18:10:28 INFO - Working with test: dromaeo_css 18:10:28 INFO - Generating results file: dromaeo_css 18:10:28 INFO - Working with test: kraken 18:10:28 INFO - Generating results file: kraken 18:10:28 INFO - javascript benchmark 18:10:28 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:10:28 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 18:10:28 INFO - process_Request line: dromaeo_css 7411.99 graph.html#tests=[[72,64,61]] 18:10:28 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:10:29 INFO - process_Request line: kraken 1497.10 graph.html#tests=[[232,64,61]] 18:10:29 INFO - RETURN: dromaeo_css: 7411.99 18:10:29 INFO - RETURN: kraken: 1497.10 18:10:29 INFO - javascript benchmark 18:10:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3517.4899639552264, 3524.665156810104, 3558.6263442338536, 3596.370635138852, 3597.0, 5314.920276195855, 5726.484616384525, 5837.0, 5865.8826823463505, 5895.145203945436, 5763.769449222036, 5824.504917082053, 5825.650460972344, 5885.49973252273, 5963.761449542013, 5132.358455193101, 5204.063268611649, 5320.467953204688, 5365.839024829242, 5387.164989426645, 5284.44513326101, 5300.469953004688, 5303.23103150043, 5355.678659280456, 5357.303550538424, 4972.676776009584, 5146.253793199984, 5237.083510385667, 5242.895142097175, 5250.501202385767, 5199.4800519948085, 5201.193814958688, 5226.55574276187, 5230.058589453897, 5258.1849813279005, 4189.476315460567, 4611.308303754464, 5184.481551844785, 5232.189010703347, 5254.054270231357, 4690.554397332248, 5218.191180367011, 5658.490735833753, 5715.514181294553, 5726.828195154152, 6237.844053898643, 6238.625682459022, 6246.187995560594, 6263.561550691454, 6276.184096067527, 4939.92590111145, 5102.0, 6157.722902469355, 6249.9062514062325, 6318.968405157991, 5932.19915311436, 5936.762529498858, 5948.078047902582, 5973.432523910222, 5993.9400605993815, 6275.96862015687, 6295.496360291166, 6316.463100636405, 6319.46284565817, 6323.051542268697, 6130.049842274455, 6139.584134579375, 6183.598066125687, 6238.563300568917, 6260.780872669435, 6144.187464697836, 6182.319944806068, 6253.187085678833, 6259.78090766821, 6262.3111457739615, 6196.659183744847, 6241.157443745036, 6254.562180647402, 6269.686515674198, 6281.96859015702, 6102.974033066861, 6126.670355029888, 6133.365267548864, 6227.595206311666, 6256.749730010749, 4949.90100197994, 4950.851474455772, 4954.777035033432, 4962.404511458576, 4988.8752781180765, 4455.309427038814, 4465.26323156682, 4478.865634030984, 4501.122281155209, 4526.275795872644, 5743.282089738783, 5768.307803063659, 5903.881922361528, 5910.4385083417865, 5915.674637894871, 6232.916877876173, 6247.687615619201, 6259.280182778948, 6263.279722831932, 6285.654289014056, 5882.49998750111, 5912.083627037816, 5926.407359264039, 5932.93207222704, 5965.3139888912465, 5357.357117145967, 5405.324334458192, 5440.238366628675, 5478.479544443271, 5505.614606977473, 5197.922031169535, 6332.398422149889, 6388.840278992877, 6415.550911436155, 6425.903611445832, 6107.037103281039, 6178.505719542336, 6240.344763799736, 6241.3134555197985, 6261.843453913689, 6258.687065646791, 6382.595828917631, 6423.518236132215, 6427.1002059710745, 6437.388448097423, 6215.316315205414, 6258.687065646791, 6262.686865656608, 6265.060240963892, 6278.372162783685, 6170.9074363885475, 6172.444479996821, 6239.812805615657, 6246.750129994931, 6273.090401891792, 4979.278004689372, 6091.695415229309, 6111.470193407107, 6210.875782484415, 6221.626702397871, 6195.256569211723, 6215.440610345091, 6218.906716399348, 6224.221972253468, 6246.5002799775, 5839.211706419579, 6054.061620448838, 6074.787382441594, 6090.451859332681, 6124.448799608057, 6129.236538068469, 6176.3514830943905, 6188.938110618837, 6193.0, 6228.844278892882, 6091.360407157362, 6093.177421048102, 6107.267127944498, 6111.052786818051, 6118.20463339763], "unit": "score", "name": "dojo.html", "value": 5722.929451237747}, {"lowerIsBetter": false, "replicates": [514.8378260847835, 565.0027701107546, 568.1846550200463, 618.0975775367964, 634.8920683483807, 29381.0, 37431.0, 37477.25045499092, 37509.81245093771, 37692.86921392362, 38229.61770382295, 38685.0, 38713.0, 38768.0, 38878.805605972004, 9381.953090234556, 9474.952625236898, 9545.188658963996, 9558.61765529378, 9603.039696030412, 9521.476318802463, 9630.422174669508, 9633.325667203299, 9642.758931026745, 9687.41875487473, 9615.038496150364, 9623.03769623039, 9648.22814174868, 9706.0, 9714.22286217101, 9464.621415143385, 9498.667546635868, 9533.332666713333, 9582.712518624452, 9644.951775241114, 9573.664921727706, 9645.37305075168, 9712.660056897974, 9730.41617502952, 9737.902620973771, 37633.24733505342, 37804.0, 37985.430218546746, 38163.66427175036, 38169.809150954345, 2606.1139212667595, 3075.630924289077, 3127.890523831678, 3478.7043101336417, 3970.987398213466, 26255.949762009688, 26265.080722174822, 26468.0736174233, 26522.204333870013, 27199.864000680067, 2704.3644743485265, 2707.241972247774, 2727.2091093583035, 2742.492638861817, 2904.259413849476, 379053.0, 381331.0, 381794.0, 382231.0, 382423.0, 59885.70057149686, 60064.39935600588, 60360.0, 60434.0, 60496.0, 62126.068108978405, 62566.0615090774, 62970.37029629645, 67577.0, 69264.6536767323, 16175.352985880432, 16491.34034638625, 16547.586310342096, 16553.25510352037, 16565.83434165667, 12219.389030548615, 12505.874941250471, 12647.810282845765, 12713.809292860615, 12765.872341276468, 17344.566385840455, 19611.509712257022, 20258.898705506377, 20405.285814996405, 20579.382618521468, 9064.54677266134, 9367.672131475365, 9393.342466027449, 9403.871535415794, 9405.200557952514, 928.9581968811419, 934.9813003740023, 941.3269512298739, 958.5399008475971, 1052.3265110329396, 22469.662955055686, 28807.135785926457, 28832.0, 29064.12807615775, 29868.40263194724, 1017.97455063624, 1026.6150193677372, 1044.7753732947301, 1044.8089178336702, 1067.7117178361955, 12438.81341779874, 14641.926790366193, 14726.705465890622, 14785.852141478663, 15003.32485038176, 400772.0, 509562.0, 509654.0, 516904.0, 528754.0, 56616.71691641598, 56780.0, 56853.71573142191, 56979.43020569824, 57333.14000289999, 1343.54991077988, 1381.4198036824357, 1385.1758203868683, 1409.7955796409462, 1421.9075760075768, 22487.662685060066, 28617.427651446436, 28898.422031559672, 28968.275793105342, 29291.0, 48583.75708121437, 48765.51234487752, 48909.75545122252, 49189.0, 49413.25880111729, 474904.0, 477637.0, 477770.0, 478580.0, 479753.0, 33016.83491582623, 33258.0, 33425.49861752124, 42282.0, 43130.78434607807, 41141.35434582703, 41157.97105072397, 41422.72175030402, 41969.740907772815, 42332.36501452542, 32949.682012719226, 34925.82537087298, 35371.82314088516, 35374.938751837486, 35426.29147417089, 27874.442511150068, 32473.512897306086, 34820.82589587137, 35352.82323588469, 35740.4638930411, 33438.39498880717, 34238.0, 35142.82428587841, 35658.82170589234, 35960.64039359573, 30526.236844079074, 32228.67771322257, 32348.35303293968, 32463.350732984734, 32476.51285230676, 22359.0, 23564.293071207892, 23973.52052958966, 24204.0, 24607.630885537088], "unit": "score", "name": "ext.html", "value": 19208.08573726436}, {"lowerIsBetter": false, "replicates": [349.4967247164084, 354.5302474221657, 360.5169073441589, 363.9053846000039, 363.9890803275903, 18707.251709931603, 19435.611287774253, 21152.682709759367, 21354.786452135475, 21406.0, 19618.901905490453, 19993.000349982514, 20061.59876802467, 20113.59772804543, 20198.0, 5824.184614154011, 6112.113743507189, 6120.571559990803, 6129.877402451948, 6146.969265153668, 4277.422547956017, 5933.673647949361, 6358.777442789503, 6661.63361015144, 6664.433523150514, 5778.7977420790285, 6435.6138631682015, 6546.541742078057, 6601.834954126137, 6621.73513059477, 5437.809676661318, 5705.201271821928, 5708.857278568027, 5712.001199370322, 5722.084466485363, 4825.697061793297, 5390.272313237702, 5431.266778984826, 5449.972750136224, 5455.099908515091, 12769.936150319281, 13284.800727988992, 13336.666583335495, 13532.458701651922, 13651.931740341333, 1743.790745110582, 2228.420610641245, 2294.4837411582425, 2552.9150111202666, 2729.6587926509187, 8105.554194519299, 9598.232141428669, 9665.806683866354, 9774.462404567746, 10163.79672406555, 1426.2155814302196, 1704.7357659562788, 1725.1201887037575, 1765.285059550884, 1769.0, 113302.30046549308, 113961.0, 115003.0, 115786.42106789412, 119174.0, 11106.500207490682, 11257.380844053656, 11277.54889804415, 11312.321260724382, 11435.885641143648, 13633.113847599874, 13659.248741319125, 13693.794593081111, 13707.109037912503, 13719.794203086962, 8395.916040839636, 8408.453450525696, 8552.315814734806, 8622.09468005863, 8657.783555411039, 8629.741107766651, 8637.395382323177, 8666.393352465393, 8716.86680731501, 8746.825063498694, 4358.084802191512, 4468.932966005513, 4491.797869095833, 4523.592876641118, 4530.818767249273, 1759.8504127149336, 1801.3875282404047, 1822.298415110192, 1866.636005978821, 1890.5746207103566, 890.2610833008588, 958.3339578992533, 971.4754032822339, 973.5862258540234, 995.5967833027636, 18791.15439805212, 19678.70481942772, 19730.802691973182, 19876.304329348404, 19993.400197994084, 923.930705197113, 938.8497840345512, 960.3277705606104, 967.9128878400978, 990.7374545745383, 8685.522296273766, 10783.13734901206, 10887.83668244977, 10903.236773425942, 10934.56261749521, 200455.0, 200572.0, 201670.0, 201816.0, 202137.0, 114585.28122078175, 114971.85028149778, 116561.0, 117986.0, 118354.40822795831, 842.7527259655744, 986.1322036607739, 996.4768496539375, 999.205631522941, 1003.0571263012745, 12665.620031399072, 17889.821101788817, 17933.0, 18455.0, 19493.92783396927, 35891.0, 44450.77774611106, 46894.76552617215, 48243.517564825306, 48727.5127248723, 55480.16779748226, 62273.44316392126, 64216.67891660512, 67794.0, 68291.65854170697, 7589.696412143452, 7820.452568320163, 8016.879746803919, 8107.756767296991, 8476.660933562589, 11462.82805757931, 13042.02184836122, 13240.139390939943, 13408.463661453823, 13484.932575337061, 7037.894431583428, 10124.683791107109, 11385.430728463709, 11392.48733806964, 11876.52493900269, 11328.150388721044, 11470.369129697612, 11626.76746465083, 11640.825387619361, 11717.648470545897, 11534.538618455168, 11818.468168932246, 11948.701282468008, 11991.940040299743, 12026.27842329463, 8070.83858322842, 8081.87877181831, 8084.151164127918, 8183.181681831769, 8372.748817535483, 8597.742067737978, 10898.087750192155, 11642.41787910618, 11815.232009919328, 11950.940245298718], "unit": "score", "name": "jquery.html", "value": 8897.377444681148}, {"lowerIsBetter": false, "replicates": [1502.3690050178923, 1511.1008949674942, 1711.8459338659518, 1839.319451802833, 1841.4475657302805, 7701.807454813633, 8244.958775206116, 8410.158984101587, 8572.914270857298, 8576.0, 6513.8926382514965, 7448.888266676005, 7547.924520754791, 8166.387520935924, 8352.081271060179, 2391.222852572912, 2414.9999999999914, 2417.625268083441, 2420.4311986683115, 2428.781409673129, 2405.7594240575977, 2412.264259400882, 2436.6954130733657, 2438.341647755114, 2446.6085426331792, 2414.4808866093786, 2429.744876787938, 2446.3639453742067, 2452.0, 2456.9017239310406, 2417.2627348658652, 2424.212131057405, 2439.9512009759883, 2441.2676197140877, 2452.896196711487, 2137.1985505435464, 2399.676043734091, 2413.2398294537165, 2424.757524247561, 2428.247243354548, 8522.70170544028, 8551.700690475804, 8562.14378562145, 8566.871496927552, 8586.828263434696, 5178.4562620924635, 5253.763580638881, 5286.207068939651, 5334.0665383557725, 5336.839894803162, 3448.77582957107, 3532.116970757311, 3537.7877327360184, 3560.1633616100194, 3578.141246100917, 1009.8232809258351, 1025.600015993763, 1030.0574973898874, 1030.2015937648307, 1034.886162522122, 10934.781304373868, 10962.397068161248, 11120.499577519031, 11237.0, 11240.49417776202, 4646.372739680168, 4753.31076993834, 4768.809247630125, 4770.475247722748, 4818.831340903052, 9492.667756628485, 9524.333296669167, 9574.856377154349, 9601.32790704644, 9605.951970240105, 4745.549172828576, 5102.005109003783, 5167.870803229949, 5189.169732842727, 5281.9207711884355, 4034.5561988181275, 4314.7626880521875, 4645.976770116128, 4758.738269395148, 4796.136695394863, 3616.8553257869917, 3702.2965636528975, 3706.981465092711, 3713.9442908356395, 3716.0338312039066, 1283.5828355784408, 1284.389914790467, 1291.9160254583421, 1295.086963690596, 1298.3702904091508, 1029.5212726082407, 1040.2354269611828, 1045.696747943088, 1166.4750862112085, 1320.0165876422127, 7842.803929901798, 7892.960535197287, 7920.722774702857, 7979.84040319202, 8021.7994550135545, 1182.6097387861985, 1184.5617121665039, 1195.8505186851644, 1224.989383758403, 1232.0882546915218, 6239.968800156061, 6255.843603909848, 6274.0, 6294.653794041372, 6309.526785491106, 9184.49485278316, 9192.17270445663, 9517.191038761644, 9532.714018579454, 9540.952295238618, 9198.862017069749, 9361.204297634642, 9420.963693993655, 9441.339106262632, 9489.952550237205, 7933.682652693943, 8016.599170041474, 8131.064927533291, 8172.509649421054, 8242.17578242171, 7652.693892244248, 7659.234076592296, 7701.961490192513, 7738.148803631709, 7753.10839253493, 9180.540972951192, 9290.256779457492, 9413.29400294967, 9457.959624441444, 9586.520673966414, 9324.254059675073, 9621.711348659552, 9648.324617277003, 9716.076972687584, 9737.561809718438, 6247.3440288769025, 6555.246146693001, 6737.797866064026, 6766.661666916733, 6863.759768408082, 7821.648025838965, 7912.090109637235, 7932.6430310637315, 7935.166807485131, 7968.7609371718945, 6987.6855541499735, 7121.181064177686, 7123.465740069619, 7194.820129496805, 7269.7455589054125, 6963.895541566779, 6989.1962424321855, 7070.151581810215, 7117.145942486728, 7122.964385178041, 7442.144153422426, 7545.0, 7564.962175189089, 7616.124145723313, 7618.961905190438, 6771.593704377753, 6775.762848300285, 6828.931710682829, 6837.418819400406, 6867.896981545381, 6940.479464040116, 6972.58164510131, 7008.194057683431, 7013.403860671696, 7018.122734658168], "unit": "score", "name": "mootools.html", "value": 4761.549435907693}, {"lowerIsBetter": false, "replicates": [322.89021732610917, 326.11785121247016, 327.95736554247947, 331.1324330254733, 334.2746240657773, 6797.218319893208, 6826.385625293723, 6850.725970961162, 6859.10831591893, 6870.519063665545, 6640.269570347258, 6713.0, 6749.763758268462, 6760.053592497042, 6803.625800580966, 4711.175544279755, 4820.783064762094, 4926.694425977101, 4964.776585053682, 4981.501849815017, 4925.82759603414, 4943.901121977558, 4945.134601444751, 4955.05853887762, 4958.107540642683, 4882.438519570242, 4885.218365061591, 4885.682430642015, 4921.557059864629, 4938.061768264036, 4885.609151267908, 4891.608671306305, 4895.36360273164, 4912.70523768575, 4918.606511479073, 4179.498460184797, 4185.0, 4186.016286172747, 4199.181159673864, 4209.810558524874, 5836.358000619928, 5870.823875283706, 6256.624602523863, 6462.48300135988, 6482.93517064828, 5878.882422351529, 5911.763529458816, 5912.379200183962, 5919.5264378850015, 5936.584439089265, 5805.564582656318, 7299.306565876233, 7304.415646748247, 7323.816904577375, 7326.96336518314, 4732.95267047332, 4740.07568524138, 4752.833650822239, 4756.905911640308, 4762.738049407281, 7625.23747625233, 7736.303732664087, 7738.419618528576, 7758.79738640506, 7778.338841198505, 4597.356370108188, 4791.257355109963, 4805.711657300573, 4816.446108697474, 4868.318435419044, 4841.515848415131, 4876.975615121973, 4881.926771098437, 4897.2654101885, 4901.387326584177, 5773.480386765212, 5885.852853678693, 5890.293164820249, 5905.881882362329, 5919.585629006015, 7330.157031941395, 7348.926510734931, 7368.19479227582, 7377.81555461107, 7386.4829461938225, 1713.5116491799777, 1740.1908112727642, 1741.5907261793468, 1742.7821522309712, 1746.5982823950308, 867.2584939876315, 1079.3362082319318, 1106.5131342209402, 1113.0427832064418, 1128.1877048525048, 5180.844574662766, 5396.64921780083, 5707.544576133142, 6500.577462464925, 6732.764353247613, 7586.127595326498, 7606.201348858401, 7613.0, 7615.010048693634, 7629.809254768676, 6511.479081673549, 6609.6364699941005, 6826.283240259801, 6834.521583489108, 6852.349026842442, 4052.412400202013, 4079.6940229482907, 4082.4692789937117, 4088.570700076449, 4088.8160032798596, 7992.920070799218, 8012.71955481567, 8025.598720063974, 8034.504990329226, 8069.072056713436, 7202.92797072033, 7277.526960747535, 7667.693292268358, 7942.722004729807, 7978.760637180778, 8006.479578827474, 8014.559199243981, 8033.799155021171, 8059.234372734581, 8062.39532035088, 7733.651985660771, 7735.806604834924, 7742.883856742041, 7753.37972962173, 7785.883211751941, 6152.354002829638, 7559.659815308214, 7579.204183560647, 7596.734114305973, 7603.771886843404, 5443.564514838724, 7210.387117095106, 8005.319547838499, 8012.118666946515, 8016.152246921394, 4354.085642015086, 4595.747233902168, 4624.190766615761, 4656.557627025427, 4669.463011753692, 6814.0, 7590.696372145052, 7621.923780762121, 7644.617769111634, 7650.846983060419, 6084.60450070744, 7258.419326453976, 7362.742304019548, 7370.520916140434, 7372.41020718352, 5605.243292155506, 7327.816804579928, 7340.449466289942, 7369.410447164107, 7416.851662966603, 7184.353408193078, 7208.495405321577, 7212.639368031682, 7215.350618444365, 7238.782836514913, 7394.075740532434, 7410.147832999274, 7424.888626670712, 7426.257374262746, 7449.478536502393, 6258.749650013949, 6869.965650171717, 7231.566106033655, 7244.0, 7244.333803225182], "unit": "score", "name": "prototype.html", "value": 5278.570592707506}, {"lowerIsBetter": false, "replicates": [688.8277930517371, 727.4980263618103, 739.9334059934605, 752.1650967426156, 758.2796343473698, 14511.709765804677, 14849.851501484982, 15038.473653422132, 15073.849261507381, 15098.849011509881, 14068.437262509513, 14079.944004199675, 14117.152970821759, 14136.646583835409, 14139.36372863221, 732.1360794262768, 870.4037734152126, 878.7890906182502, 898.5148020069188, 900.7748062984253, 892.0321451225428, 894.785251539629, 896.9775755606097, 898.8516894712365, 900.2033200617435, 946.2146418472652, 948.4025064209538, 949.3070058857004, 950.0831697411996, 950.3157726436955, 875.4528419737663, 887.2857349833381, 889.204162274767, 904.3443503459972, 937.7186843946823, 651.9608823470606, 656.4682607088274, 684.2780866186172, 689.3382352941182, 701.7263267325696, 14755.40978360875, 14939.626509337244, 14939.70120597582, 14978.775318370124, 15027.699446011127, 12587.992960563133, 12619.684507887285, 12685.112042157052, 12827.294498802563, 12905.612831615066, 9884.65403710874, 10089.445080520569, 10089.495525223709, 10108.292419530635, 10392.272540922138, 3463.307338532278, 3496.318217947501, 3498.807565583892, 3506.6318036606044, 3584.9641503585153, 82337.0, 83349.0, 84567.15432845654, 84591.57704211501, 84750.57624711898, 8101.918980810235, 9386.108319709616, 9441.858372124423, 9545.140937315675, 9947.452890091114, 21870.671939920914, 21893.890530547244, 21906.78093219079, 21952.0, 21969.011394487286, 7103.680334384965, 7278.308560686726, 7349.853002939912, 7435.442341824385, 7680.270374314431, 3959.3467077932396, 3967.2858885400906, 4014.217227640582, 4015.297322968469, 4053.4527838741983, 3478.4956181353564, 3506.631803660579, 3523.5419395478934, 3531.2760884018717, 3551.1654761131113, 612.9693515324306, 613.910982907476, 613.9899864722506, 628.2021832272987, 629.7764293675771, 472.0605994071841, 498.94761050089215, 547.6036107924855, 582.9854253643608, 611.9632822030692, 7952.721654742057, 8001.479903806234, 8097.433179677366, 8110.878336824952, 8232.306196551552, 496.76900241387204, 523.4007061914087, 571.6770024935898, 602.6233603997501, 625.2376742738936, 2933.3545823082327, 3833.926500579842, 3913.92172156561, 3951.940720889189, 3952.822123004414, 50782.0, 86620.56689716637, 86766.56616716876, 87406.0, 87549.0, 76814.61592692001, 77018.61490692623, 77075.0, 77508.0, 78084.0, 61377.07934380988, 66105.0, 66536.0, 67372.66313668498, 67644.6617766908, 7750.806229844299, 7809.726659566888, 7949.642266097924, 8007.0, 8089.8382032360205, 42309.57690423179, 46321.0, 46552.76723616496, 49860.75069624629, 50463.99072018613, 61693.691531542056, 63053.0, 65846.0, 68912.3108768906, 70421.29578704147, 10298.605976089542, 10531.89468105309, 10786.406747628957, 10912.236143469881, 11063.114950803756, 11592.880416185348, 11646.650600481998, 11715.531378744754, 11910.761784764083, 12255.365096504294, 10956.178286628376, 11010.559577616805, 11310.0, 11452.14108941816, 11759.000484958533, 11082.722931926766, 11095.72260693489, 11133.387663678575, 11177.66467005991, 11508.194426390073, 10451.529681164213, 10970.725731856768, 10985.890141098487, 11141.83287250708, 11349.48927298257, 9127.0, 9299.809954796046, 9371.531423428938, 9395.906040939502, 9513.809723805623, 7182.75658769091, 9201.125893040151, 9445.291603129655, 9445.763855903382, 9707.563159657973], "unit": "score", "name": "yui.html", "value": 6744.461350817907}], "name": "dromaeo_css", "value": 7411.993019152109}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 105.0, 114.0, 115.0, 116.0, 124.0, 114.0, 115.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.3}, {"lowerIsBetter": true, "replicates": [153.0, 123.0, 147.0, 155.0, 121.0, 146.0, 149.0, 148.0, 165.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 142.9}, {"lowerIsBetter": true, "replicates": [196.0, 198.0, 201.0, 202.0, 205.0, 229.0, 268.0, 276.0, 227.0, 195.0], "unit": "score", "name": "audio-dft", "value": 219.7}, {"lowerIsBetter": true, "replicates": [69.0, 75.0, 70.0, 124.0, 57.0, 57.0, 56.0, 58.0, 121.0, 51.0], "unit": "score", "name": "audio-fft", "value": 73.8}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 132.0, 77.0, 79.0, 81.0, 119.0, 78.0, 81.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 93.4}, {"lowerIsBetter": true, "replicates": [89.0, 85.0, 89.0, 88.0, 102.0, 86.0, 89.0, 86.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 94.0, 116.0, 136.0, 95.0, 103.0, 95.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 101.9}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 94.0, 91.0, 94.0, 95.0, 145.0, 154.0, 93.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 104.4}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 61.0, 55.0, 55.0, 57.0, 55.0, 64.0, 58.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 70.0, 67.0, 73.0, 72.0, 70.0, 67.0, 67.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 83.0, 83.0, 87.0, 84.0, 86.0, 85.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [141.0, 116.0, 136.0, 141.0, 132.0, 124.0, 134.0, 131.0, 122.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.9}, {"lowerIsBetter": true, "replicates": [182.0, 147.0, 139.0, 139.0, 143.0, 140.0, 185.0, 138.0, 138.0, 129.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 71.0, 66.0, 66.0, 59.0, 56.0, 60.0, 75.0, 89.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1497.1000000000001}]} 18:10:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1497.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7411.99"}}} 18:10:29 INFO - Return code: 0 18:10:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:10:29 ERROR - # TBPL SUCCESS # 18:10:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:10:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:10:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:10:29 INFO - 2016-03-01 18:10:29.173 screenresolution[2325:72665] starting screenresolution argv=screenresolution get 18:10:29 INFO - 2016-03-01 18:10:29.175 screenresolution[2325:72665] Display 0: 1600x1200x32@60 18:10:29 INFO - 2016-03-01 18:10:29.181 screenresolution[2326:72668] starting screenresolution argv=screenresolution list 18:10:29 INFO - Available Modes on Display 0 18:10:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:10:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:10:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:10:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:10:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:10:29 INFO - Intel Iris: 18:10:29 INFO - Chipset Model: Intel Iris 18:10:29 INFO - Type: GPU 18:10:29 INFO - Bus: Built-In 18:10:29 INFO - VRAM (Dynamic, Max): 1536 MB 18:10:29 INFO - Vendor: Intel (0x8086) 18:10:29 INFO - Device ID: 0x0a2e 18:10:29 INFO - Revision ID: 0x0009 18:10:29 INFO - Displays: 18:10:29 INFO - Display: 18:10:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:10:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:10:29 INFO - Display Serial Number: 1600x1200 60 18:10:29 INFO - Main Display: Yes 18:10:29 INFO - Mirror: Off 18:10:29 INFO - Online: Yes 18:10:29 INFO - Rotation: Supported 18:10:29 INFO - Return code: 0 18:10:29 INFO - Running post-action listener: _resource_record_post_action 18:10:29 INFO - Running post-run listener: _resource_record_post_run 18:10:30 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 0; Write bytes: 703209472; Read time: 0; Write time: 2242 18:10:30 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 381762048; Write bytes: 376608768; Read time: 28178; Write time: 760 18:10:30 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 0; Write bytes: 299067392; Read time: 0; Write time: 1425 18:10:30 INFO - Running post-run listener: _upload_blobber_files 18:10:30 INFO - Blob upload gear active. 18:10:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:10:30 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 18:10:30 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'] 18:10:30 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 18:10:30 INFO - (blobuploader) - INFO - Open directory for files ... 18:10:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:10:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:10:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:31 INFO - (blobuploader) - INFO - Done attempting. 18:10:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:10:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:10:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:33 INFO - (blobuploader) - INFO - Done attempting. 18:10:33 INFO - (blobuploader) - INFO - Iteration through files over. 18:10:33 INFO - Return code: 0 18:10:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:10:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:10:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74790bc380f90c6b739906fa8b2af4b91805d97646e7878edbc7b9ed3fa8a74de77571907c4f2fe51e6ed2ec5c3018b06f401e82352e7e430de31c2aacc73f34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/372ce8b220a9d0fbb35966ea6b923177d26af8a6fa0c68fdfdfe96552141220e04cc6618fa0d25bf788e9f451020780ac432848dcc44f2ee2f41801def20f8f9"} 18:10:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:10:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:10:33 INFO - Contents: 18:10:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74790bc380f90c6b739906fa8b2af4b91805d97646e7878edbc7b9ed3fa8a74de77571907c4f2fe51e6ed2ec5c3018b06f401e82352e7e430de31c2aacc73f34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/372ce8b220a9d0fbb35966ea6b923177d26af8a6fa0c68fdfdfe96552141220e04cc6618fa0d25bf788e9f451020780ac432848dcc44f2ee2f41801def20f8f9"} 18:10:33 INFO - Running post-run listener: copy_logs_to_upload_dir 18:10:33 INFO - Copying logs to upload dir... 18:10:33 INFO - mkdir: /builds/slave/test/build/upload/logs 18:10:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.697894 ========= master_lag: 4.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-01 18:10:37.887222) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 18:10:37.890233) ========= 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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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/74790bc380f90c6b739906fa8b2af4b91805d97646e7878edbc7b9ed3fa8a74de77571907c4f2fe51e6ed2ec5c3018b06f401e82352e7e430de31c2aacc73f34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/372ce8b220a9d0fbb35966ea6b923177d26af8a6fa0c68fdfdfe96552141220e04cc6618fa0d25bf788e9f451020780ac432848dcc44f2ee2f41801def20f8f9"} build_url:https://queue.taskcluster.net/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011134 build_url: 'https://queue.taskcluster.net/v1/task/Osb_wftkQ9-db4eRZ95eJA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74790bc380f90c6b739906fa8b2af4b91805d97646e7878edbc7b9ed3fa8a74de77571907c4f2fe51e6ed2ec5c3018b06f401e82352e7e430de31c2aacc73f34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/372ce8b220a9d0fbb35966ea6b923177d26af8a6fa0c68fdfdfe96552141220e04cc6618fa0d25bf788e9f451020780ac432848dcc44f2ee2f41801def20f8f9"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 18:10:37.990696) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 18:10:37.991034) ========= 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.YwAQ4mGgcq/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.eYJIDcjRTy/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.005609 ========= master_lag: 0.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 18:10:38.284273) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 18:10:38.284592) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 18:10:38.284961) ========= ========= Total master_lag: 5.14 =========