builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0082 starttime: 1454065618.62 results: success (0) buildid: 20160129021926 builduid: 712852dd62c642a795d6650f6e3951dc revision: 0ae6c7e277af505c6b13f8ba97e5618b0e8ffdfc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 03:06:58.618396) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 03:06:58.618851) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 03:06:58.619295) ========= 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.2rap4uRDWb/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.IwRL97s1tH/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.005675 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 03:06:58.645168) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 03:06:58.645434) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 03:06:58.670376) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 03:06:58.670646) ========= 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.2rap4uRDWb/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.IwRL97s1tH/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.005545 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 03:06:58.846453) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 03:06:58.846719) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 03:06:58.847071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 03:06:58.847338) ========= 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.2rap4uRDWb/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.IwRL97s1tH/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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-01-29 03:06:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-01-29 03:06:58 (37.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130020 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 03:06:59.073285) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 03:06:59.073649) ========= 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.2rap4uRDWb/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.IwRL97s1tH/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.019902 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 03:06:59.153141) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-29 03:06:59.153540) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ae6c7e277af505c6b13f8ba97e5618b0e8ffdfc --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 0ae6c7e277af505c6b13f8ba97e5618b0e8ffdfc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2rap4uRDWb/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.IwRL97s1tH/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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-01-29 03:06:59,255 truncating revision to first 12 chars 2016-01-29 03:06:59,255 Setting DEBUG logging. 2016-01-29 03:06:59,255 attempt 1/10 2016-01-29 03:06:59,255 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ae6c7e277af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-29 03:07:00,068 unpacking tar archive at: fx-team-0ae6c7e277af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.057557 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-29 03:07:00.257967) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 03:07:00.258450) ========= echo 0ae6c7e277af505c6b13f8ba97e5618b0e8ffdfc in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0ae6c7e277af505c6b13f8ba97e5618b0e8ffdfc'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2rap4uRDWb/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.IwRL97s1tH/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 0ae6c7e277af505c6b13f8ba97e5618b0e8ffdfc program finished with exit code 0 elapsedTime=0.005006 script_repo_revision: '0ae6c7e277af505c6b13f8ba97e5618b0e8ffdfc' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 03:07:00.309190) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 03:07:00.309477) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 03:07:00.321976) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-01-29 03:07:00.322275) ========= /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.2rap4uRDWb/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.IwRL97s1tH/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 03:07:00 INFO - MultiFileLogger online at 20160129 03:07:00 in /builds/slave/test 03:07:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 03:07:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:07:00 INFO - {'append_to_log': False, 03:07:00 INFO - 'base_work_dir': '/builds/slave/test', 03:07:00 INFO - 'blob_upload_branch': 'Fx-Team', 03:07:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:07:00 INFO - 'branch': 'Fx-Team', 03:07:00 INFO - 'buildbot_json_path': 'buildprops.json', 03:07:00 INFO - 'config_files': ('talos/mac_config.py',), 03:07:00 INFO - 'default_actions': ('clobber', 03:07:00 INFO - 'read-buildbot-config', 03:07:00 INFO - 'download-and-extract', 03:07:00 INFO - 'populate-webroot', 03:07:00 INFO - 'create-virtualenv', 03:07:00 INFO - 'install', 03:07:00 INFO - 'run-tests'), 03:07:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:07:00 INFO - 'download_minidump_stackwalk': True, 03:07:00 INFO - 'download_symbols': 'ondemand', 03:07:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:07:00 INFO - 'tooltool.py': '/tools/tooltool.py', 03:07:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:07:00 INFO - '/tools/misc-python/virtualenv.py')}, 03:07:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:07:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:07:00 INFO - 'installer_path': 'installer.exe', 03:07:00 INFO - 'log_level': 'info', 03:07:00 INFO - 'log_name': 'talos', 03:07:00 INFO - 'log_to_console': True, 03:07:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:07:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:07:00 INFO - 'opt_config_files': (), 03:07:00 INFO - 'pip_index': False, 03:07:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:07:00 INFO - 'cmd': ('bash', 03:07:00 INFO - '-c', 03:07:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:07:00 INFO - 'enabled': True, 03:07:00 INFO - 'halt_on_failure': False, 03:07:00 INFO - 'name': 'check_screen_resolution'},), 03:07:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:07:00 INFO - 'cmd': ('bash', 03:07:00 INFO - '-c', 03:07:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:07:00 INFO - 'enabled': True, 03:07:00 INFO - 'halt_on_failure': False, 03:07:00 INFO - 'name': 'check_screen_resolution'},), 03:07:00 INFO - 'run_cmd_checks_enabled': True, 03:07:00 INFO - 'sps_profile': False, 03:07:00 INFO - 'sps_profile_interval': 0, 03:07:00 INFO - 'suite': 'dromaeojs-e10s', 03:07:00 INFO - 'system_bits': '32', 03:07:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:07:00 INFO - 'title': 't-yosemite-r7-0082', 03:07:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:07:00 INFO - 'use_talos_json': True, 03:07:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:07:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:07:00 INFO - 'work_dir': 'build'} 03:07:00 INFO - ##### 03:07:00 INFO - ##### Running clobber step. 03:07:00 INFO - ##### 03:07:00 INFO - Running pre-action listener: _resource_record_pre_action 03:07:00 INFO - Running main action method: clobber 03:07:00 INFO - rmtree: /builds/slave/test/build 03:07:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:07:01 INFO - Running post-action listener: _resource_record_post_action 03:07:01 INFO - ##### 03:07:01 INFO - ##### Running read-buildbot-config step. 03:07:01 INFO - ##### 03:07:01 INFO - Running pre-action listener: _resource_record_pre_action 03:07:01 INFO - Running main action method: read_buildbot_config 03:07:01 INFO - Using buildbot properties: 03:07:01 INFO - { 03:07:01 INFO - "project": "", 03:07:01 INFO - "product": "firefox", 03:07:01 INFO - "script_repo_revision": "production", 03:07:01 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 03:07:01 INFO - "repository": "", 03:07:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 03:07:01 INFO - "buildid": "20160129021926", 03:07:01 INFO - "pgo_build": "False", 03:07:01 INFO - "basedir": "/builds/slave/test", 03:07:01 INFO - "buildnumber": 272, 03:07:01 INFO - "slavename": "t-yosemite-r7-0082", 03:07:01 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:07:01 INFO - "platform": "yosemite_r7", 03:07:01 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:07:01 INFO - "branch": "fx-team", 03:07:01 INFO - "repo_path": "integration/fx-team", 03:07:01 INFO - "revision": "0ae6c7e277af505c6b13f8ba97e5618b0e8ffdfc", 03:07:01 INFO - "stage_platform": "macosx64", 03:07:01 INFO - "builduid": "712852dd62c642a795d6650f6e3951dc", 03:07:01 INFO - "slavebuilddir": "test" 03:07:01 INFO - } 03:07:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 03:07:01 INFO - Running post-action listener: _resource_record_post_action 03:07:01 INFO - ##### 03:07:01 INFO - ##### Running download-and-extract step. 03:07:01 INFO - ##### 03:07:01 INFO - Running pre-action listener: _resource_record_pre_action 03:07:01 INFO - Running main action method: download_and_extract 03:07:01 INFO - mkdir: /builds/slave/test/build/tests 03:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:01 INFO - https://queue.taskcluster.net/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:07:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/test_packages.json 03:07:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/test_packages.json 03:07:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:07:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:07:03 INFO - Downloaded 1277 bytes. 03:07:03 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:07:03 INFO - Using the following test package requirements: 03:07:03 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:07:03 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:07:03 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 03:07:03 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:07:03 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 03:07:03 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:07:03 INFO - u'jsshell-mac.zip'], 03:07:03 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:07:03 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 03:07:03 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:07:03 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:07:03 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 03:07:03 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:07:03 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 03:07:03 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:07:03 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 03:07:03 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:07:03 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:07:03 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 03:07:03 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:03 INFO - https://queue.taskcluster.net/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/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 03:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/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 03:07:04 INFO - Downloaded 16723978 bytes. 03:07:04 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'] 03:07:04 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 03:07:07 INFO - Return code: 0 03:07:07 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 03:07: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')]} 03:07:07 INFO - https://queue.taskcluster.net/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:07:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:07:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:07:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/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 03:07:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/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 03:07:09 INFO - Downloaded 16723978 bytes. 03:07:09 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'] 03:07:09 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 03:07:13 INFO - Return code: 0 03:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:13 INFO - https://queue.taskcluster.net/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:07:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:07:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:07:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/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 03:07:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/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 03:07:15 INFO - Downloaded 10706582 bytes. 03:07:15 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'] 03:07:15 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 03:07:15 INFO - Return code: 0 03:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:15 INFO - https://queue.taskcluster.net/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:07:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:07:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:07:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 03:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K5kKNuyzTSm264mZM9ElPA/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 03:07:18 INFO - Downloaded 111045843 bytes. 03:07:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:07:18 INFO - mkdir: /builds/slave/test/properties 03:07:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:07:18 INFO - Writing to file /builds/slave/test/properties/build_url 03:07:18 INFO - Contents: 03:07:18 INFO - build_url:https://queue.taskcluster.net/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:07:18 INFO - Running post-action listener: _resource_record_post_action 03:07:18 INFO - Running post-action listener: set_extra_try_arguments 03:07:18 INFO - ##### 03:07:18 INFO - ##### Running populate-webroot step. 03:07:18 INFO - ##### 03:07:18 INFO - Running pre-action listener: _resource_record_pre_action 03:07:18 INFO - Running main action method: populate_webroot 03:07:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:07:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:07:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:07:18 INFO - '--tppagecycles', 03:07:18 INFO - '7'], 03:07:18 INFO - 'tests': ['tsvgm']}}, 03:07:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:07:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:07:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:07:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:07:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:07:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:07:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:18 INFO - 'talos_options': ['--e10s'], 03:07:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:18 INFO - 'tests': ['damp', 'tps']}, 03:07:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:18 INFO - 'talos_options': ['--e10s'], 03:07:18 INFO - 'tests': ['damp', 'tps']}, 03:07:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:07:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:07:18 INFO - 'other': {'tests': ['a11yr', 03:07:18 INFO - 'ts_paint', 03:07:18 INFO - 'tpaint', 03:07:18 INFO - 'sessionrestore', 03:07:18 INFO - 'sessionrestore_no_auto_restore']}, 03:07:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:07:18 INFO - 'tests': ['a11yr', 03:07:18 INFO - 'ts_paint', 03:07:18 INFO - 'tpaint', 03:07:18 INFO - 'sessionrestore', 03:07:18 INFO - 'sessionrestore_no_auto_restore']}, 03:07:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:07:18 INFO - 'tests': ['a11yr', 03:07:18 INFO - 'ts_paint', 03:07:18 INFO - 'tpaint', 03:07:18 INFO - 'sessionrestore', 03:07:18 INFO - 'sessionrestore_no_auto_restore']}, 03:07:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:07:18 INFO - 'tests': ['a11yr', 03:07:18 INFO - 'ts_paint', 03:07:18 INFO - 'tpaint', 03:07:18 INFO - 'sessionrestore', 03:07:18 INFO - 'sessionrestore_no_auto_restore']}, 03:07:18 INFO - 'other_l64': {'tests': ['a11yr', 03:07:18 INFO - 'ts_paint', 03:07:18 INFO - 'tpaint', 03:07:18 INFO - 'sessionrestore', 03:07:18 INFO - 'sessionrestore_no_auto_restore']}, 03:07:18 INFO - 'other_nol64': {'tests': ['a11yr', 03:07:18 INFO - 'ts_paint', 03:07:18 INFO - 'tpaint', 03:07:18 INFO - 'sessionrestore', 03:07:18 INFO - 'sessionrestore_no_auto_restore']}, 03:07:18 INFO - 'svgr': {'tests': ['tsvgx', 03:07:18 INFO - 'tsvgr_opacity', 03:07:18 INFO - 'tart', 03:07:18 INFO - 'tscrollx', 03:07:18 INFO - 'cart']}, 03:07:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:07:18 INFO - 'tests': ['tsvgx', 03:07:18 INFO - 'tsvgr_opacity', 03:07:18 INFO - 'tart', 03:07:18 INFO - 'tscrollx', 03:07:18 INFO - 'cart']}, 03:07:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:18 INFO - 'tests': ['tp5o']}, 03:07:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:18 INFO - 'talos_options': ['--e10s'], 03:07:18 INFO - 'tests': ['tp5o']}, 03:07:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:18 INFO - 'talos_options': ['--xperf_path', 03:07:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:18 INFO - 'tests': ['tp5n']}, 03:07:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:18 INFO - 'talos_options': ['--e10s', 03:07:18 INFO - '--xperf_path', 03:07:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:18 INFO - 'tests': ['tp5n']}}, 03:07:18 INFO - 'talos.zip': {'path': '', 03:07:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:07:18 INFO - Running post-action listener: _resource_record_post_action 03:07:18 INFO - ##### 03:07:18 INFO - ##### Running create-virtualenv step. 03:07:18 INFO - ##### 03:07:18 INFO - Running pre-action listener: _resource_record_pre_action 03:07:18 INFO - Running main action method: create_virtualenv 03:07:18 INFO - Creating virtualenv /builds/slave/test/build/venv 03:07:18 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 03:07:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:07:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:07:18 INFO - Using real prefix '/tools/python27' 03:07:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:07:19 INFO - Installing distribute.............................................................................................................................................................................................done. 03:07:22 INFO - Installing pip.................done. 03:07:22 INFO - Return code: 0 03:07:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:22 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 0x1073f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3b564c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729bd30>, '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 0x1070fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.2rap4uRDWb/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.IwRL97s1tH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 03:07:22 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 03:07:22 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 03:07:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rap4uRDWb/Render', 03:07:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:22 INFO - 'HOME': '/Users/cltbld', 03:07:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:22 INFO - 'LOGNAME': 'cltbld', 03:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:22 INFO - 'MOZ_NO_REMOTE': '1', 03:07:22 INFO - 'NO_EM_RESTART': '1', 03:07:22 INFO - 'PAGER': '/bin/cat', 03:07:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:22 INFO - 'PWD': '/builds/slave/test', 03:07:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:22 INFO - 'SHELL': '/bin/bash', 03:07:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IwRL97s1tH/Listeners', 03:07:22 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 03:07:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:22 INFO - 'USER': 'cltbld', 03:07:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:22 INFO - 'XPC_FLAGS': '0x0', 03:07:22 INFO - 'XPC_SERVICE_NAME': '0', 03:07:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:22 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 03:07:22 INFO - Cleaning up... 03:07:22 INFO - Return code: 0 03:07:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:22 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 0x1073f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3b564c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729bd30>, '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 0x1070fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.2rap4uRDWb/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.IwRL97s1tH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 03:07:22 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 03:07:22 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 03:07:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rap4uRDWb/Render', 03:07:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:22 INFO - 'HOME': '/Users/cltbld', 03:07:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:22 INFO - 'LOGNAME': 'cltbld', 03:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:22 INFO - 'MOZ_NO_REMOTE': '1', 03:07:22 INFO - 'NO_EM_RESTART': '1', 03:07:22 INFO - 'PAGER': '/bin/cat', 03:07:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:22 INFO - 'PWD': '/builds/slave/test', 03:07:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:22 INFO - 'SHELL': '/bin/bash', 03:07:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IwRL97s1tH/Listeners', 03:07:22 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 03:07:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:22 INFO - 'USER': 'cltbld', 03:07:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:22 INFO - 'XPC_FLAGS': '0x0', 03:07:22 INFO - 'XPC_SERVICE_NAME': '0', 03:07:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:22 INFO - Downloading/unpacking psutil>=0.7.1 03:07:22 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 03:07:22 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 03:07:22 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 03:07:22 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 03:07:22 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 03:07:22 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 03:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:07:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:25 INFO - Installing collected packages: psutil 03:07:25 INFO - Running setup.py install for psutil 03:07:26 INFO - building 'psutil._psutil_osx' extension 03:07:26 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 03:07:26 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 03:07:26 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 03:07:26 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 03:07:26 INFO - building 'psutil._psutil_posix' extension 03:07:26 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 03:07:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:07:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:07:26 INFO - ^ 03:07:26 INFO - 1 warning generated. 03:07:26 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 03:07:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:26 INFO - Successfully installed psutil 03:07:26 INFO - Cleaning up... 03:07:26 INFO - Return code: 0 03:07:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1073f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3b564c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729bd30>, '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 0x1070fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.2rap4uRDWb/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.IwRL97s1tH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 03:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:07:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rap4uRDWb/Render', 03:07:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:26 INFO - 'HOME': '/Users/cltbld', 03:07:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:26 INFO - 'LOGNAME': 'cltbld', 03:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:26 INFO - 'MOZ_NO_REMOTE': '1', 03:07:26 INFO - 'NO_EM_RESTART': '1', 03:07:26 INFO - 'PAGER': '/bin/cat', 03:07:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:26 INFO - 'PWD': '/builds/slave/test', 03:07:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:26 INFO - 'SHELL': '/bin/bash', 03:07:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IwRL97s1tH/Listeners', 03:07:26 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 03:07:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:26 INFO - 'USER': 'cltbld', 03:07:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:26 INFO - 'XPC_FLAGS': '0x0', 03:07:26 INFO - 'XPC_SERVICE_NAME': '0', 03:07:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:07:27 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 03:07:27 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 03:07:27 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 03:07:27 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 03:07:27 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 03:07:27 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 03:07:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:07:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:07:29 INFO - Installing collected packages: mozsystemmonitor 03:07:29 INFO - Running setup.py install for mozsystemmonitor 03:07:29 INFO - Successfully installed mozsystemmonitor 03:07:29 INFO - Cleaning up... 03:07:29 INFO - Return code: 0 03:07:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1073f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3b564c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729bd30>, '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 0x1070fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.2rap4uRDWb/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.IwRL97s1tH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 03:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:07:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rap4uRDWb/Render', 03:07:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:29 INFO - 'HOME': '/Users/cltbld', 03:07:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:29 INFO - 'LOGNAME': 'cltbld', 03:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:29 INFO - 'MOZ_NO_REMOTE': '1', 03:07:29 INFO - 'NO_EM_RESTART': '1', 03:07:29 INFO - 'PAGER': '/bin/cat', 03:07:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:29 INFO - 'PWD': '/builds/slave/test', 03:07:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:29 INFO - 'SHELL': '/bin/bash', 03:07:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IwRL97s1tH/Listeners', 03:07:29 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 03:07:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:29 INFO - 'USER': 'cltbld', 03:07:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:29 INFO - 'XPC_FLAGS': '0x0', 03:07:29 INFO - 'XPC_SERVICE_NAME': '0', 03:07:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:30 INFO - Downloading/unpacking blobuploader==1.2.4 03:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:32 INFO - Downloading blobuploader-1.2.4.tar.gz 03:07:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:07:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:07:32 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 03:07:32 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 03:07:32 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 03:07:32 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 03:07:32 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 03:07:32 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 03:07:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:07:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:33 INFO - Downloading docopt-0.6.1.tar.gz 03:07:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:07:33 INFO - Installing collected packages: blobuploader, requests, docopt 03:07:33 INFO - Running setup.py install for blobuploader 03:07:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:07:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:07:33 INFO - Running setup.py install for requests 03:07:34 INFO - Running setup.py install for docopt 03:07:34 INFO - Successfully installed blobuploader requests docopt 03:07:34 INFO - Cleaning up... 03:07:34 INFO - Return code: 0 03:07:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:34 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')]} 03:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:34 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')]} 03:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:34 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 0x1073f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3b564c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729bd30>, '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 0x1070fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.2rap4uRDWb/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.IwRL97s1tH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 03:07:34 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 03:07:34 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 03:07:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rap4uRDWb/Render', 03:07:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:34 INFO - 'HOME': '/Users/cltbld', 03:07:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:34 INFO - 'LOGNAME': 'cltbld', 03:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:34 INFO - 'MOZ_NO_REMOTE': '1', 03:07:34 INFO - 'NO_EM_RESTART': '1', 03:07:34 INFO - 'PAGER': '/bin/cat', 03:07:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:34 INFO - 'PWD': '/builds/slave/test', 03:07:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:34 INFO - 'SHELL': '/bin/bash', 03:07:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IwRL97s1tH/Listeners', 03:07:34 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 03:07:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:34 INFO - 'USER': 'cltbld', 03:07:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:34 INFO - 'XPC_FLAGS': '0x0', 03:07:34 INFO - 'XPC_SERVICE_NAME': '0', 03:07:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:34 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-8CESCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:34 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-_v6sYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:34 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-i742do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:34 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-hAbF8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-LpEadV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-0BdYB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-MTP8yZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-UjRvSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-yG_8lT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-n4zEWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-DqkDCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-QzepD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:35 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-bwTfOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:36 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-0UzhAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:36 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-gZQDHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:36 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-r8oO6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:36 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-OJCrqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:07:36 INFO - Running setup.py install for manifestparser 03:07:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:07:36 INFO - Running setup.py install for mozcrash 03:07:36 INFO - Running setup.py install for mozdebug 03:07:36 INFO - Running setup.py install for mozdevice 03:07:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:07:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:07:37 INFO - Running setup.py install for mozfile 03:07:37 INFO - Running setup.py install for mozhttpd 03:07:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:07:37 INFO - Running setup.py install for mozinfo 03:07:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:07:37 INFO - Running setup.py install for mozInstall 03:07:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:07:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:07:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:07:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:07:37 INFO - Running setup.py install for mozleak 03:07:37 INFO - Running setup.py install for mozlog 03:07:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:07:37 INFO - Running setup.py install for moznetwork 03:07:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:07:38 INFO - Running setup.py install for mozprocess 03:07:38 INFO - Running setup.py install for mozprofile 03:07:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:07:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:07:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:07:38 INFO - Running setup.py install for mozrunner 03:07:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:07:38 INFO - Running setup.py install for mozscreenshot 03:07:38 INFO - Running setup.py install for moztest 03:07:38 INFO - Running setup.py install for mozversion 03:07:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:07:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:07:38 INFO - Cleaning up... 03:07:38 INFO - Return code: 0 03:07:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:38 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 0x1073f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3b564c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729bd30>, '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 0x1070fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.2rap4uRDWb/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.IwRL97s1tH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 03:07:38 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 03:07:38 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 03:07:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rap4uRDWb/Render', 03:07:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:38 INFO - 'HOME': '/Users/cltbld', 03:07:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:38 INFO - 'LOGNAME': 'cltbld', 03:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:38 INFO - 'MOZ_NO_REMOTE': '1', 03:07:38 INFO - 'NO_EM_RESTART': '1', 03:07:38 INFO - 'PAGER': '/bin/cat', 03:07:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:38 INFO - 'PWD': '/builds/slave/test', 03:07:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:38 INFO - 'SHELL': '/bin/bash', 03:07:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IwRL97s1tH/Listeners', 03:07:38 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 03:07:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:38 INFO - 'USER': 'cltbld', 03:07:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:39 INFO - 'XPC_FLAGS': '0x0', 03:07:39 INFO - 'XPC_SERVICE_NAME': '0', 03:07:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-6pKc88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:39 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)) 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-UZe4CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:39 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)) 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-NwVWZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:39 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)) 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-FR90ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:39 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)) 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-KU13_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:39 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)) 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-JgoQHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:39 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)) 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-xUl0Nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:40 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)) 03:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-g6gRZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:40 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)) 03:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-BLCBgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:40 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)) 03:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-ZVglWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:40 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)) 03:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-NViC0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:40 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)) 03:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-paBE98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:40 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)) 03:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-0yMMaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:40 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)) 03:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-XkasmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:40 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)) 03:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-UUtawL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:40 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)) 03:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-JptzZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:41 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)) 03:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:41 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-5AKuFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:41 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)) 03:07:41 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)) 03:07:41 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)) 03:07:41 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)) 03:07:41 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)) 03:07:41 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)) 03:07:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:07:41 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 03:07:41 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 03:07:41 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 03:07:41 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 03:07:41 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 03:07:41 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 03:07:43 INFO - Downloading blessings-1.6.tar.gz 03:07:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:07:43 INFO - Installing collected packages: blessings 03:07:43 INFO - Running setup.py install for blessings 03:07:43 INFO - Successfully installed blessings 03:07:43 INFO - Cleaning up... 03:07:43 INFO - Return code: 0 03:07:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:07:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:44 INFO - Reading from file tmpfile_stdout 03:07:44 INFO - Current package versions: 03:07:44 INFO - blessings == 1.6 03:07:44 INFO - blobuploader == 1.2.4 03:07:44 INFO - docopt == 0.6.1 03:07:44 INFO - manifestparser == 1.1 03:07:44 INFO - mozInstall == 1.12 03:07:44 INFO - mozcrash == 0.16 03:07:44 INFO - mozdebug == 0.1 03:07:44 INFO - mozdevice == 0.48 03:07:44 INFO - mozfile == 1.2 03:07:44 INFO - mozhttpd == 0.7 03:07:44 INFO - mozinfo == 0.9 03:07:44 INFO - mozleak == 0.1 03:07:44 INFO - mozlog == 3.1 03:07:44 INFO - moznetwork == 0.27 03:07:44 INFO - mozprocess == 0.22 03:07:44 INFO - mozprofile == 0.28 03:07:44 INFO - mozrunner == 6.11 03:07:44 INFO - mozscreenshot == 0.1 03:07:44 INFO - mozsystemmonitor == 0.0 03:07:44 INFO - moztest == 0.7 03:07:44 INFO - mozversion == 1.4 03:07:44 INFO - psutil == 3.1.1 03:07:44 INFO - requests == 1.2.3 03:07:44 INFO - wsgiref == 0.1.2 03:07:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:44 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')]} 03:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:44 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')]} 03:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:44 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 0x1073f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3b564c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729bd30>, '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 0x1070fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.2rap4uRDWb/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.IwRL97s1tH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 03:07:44 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 03:07:44 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 03:07:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rap4uRDWb/Render', 03:07:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:44 INFO - 'HOME': '/Users/cltbld', 03:07:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:44 INFO - 'LOGNAME': 'cltbld', 03:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:44 INFO - 'MOZ_NO_REMOTE': '1', 03:07:44 INFO - 'NO_EM_RESTART': '1', 03:07:44 INFO - 'PAGER': '/bin/cat', 03:07:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:44 INFO - 'PWD': '/builds/slave/test', 03:07:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:44 INFO - 'SHELL': '/bin/bash', 03:07:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IwRL97s1tH/Listeners', 03:07:44 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 03:07:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:44 INFO - 'USER': 'cltbld', 03:07:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:44 INFO - 'XPC_FLAGS': '0x0', 03:07:44 INFO - 'XPC_SERVICE_NAME': '0', 03:07:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 INFO - Cleaning up... 03:07:44 INFO - Return code: 0 03:07:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:07:44 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')]} 03:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:44 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')]} 03:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:44 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 0x1073f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3b564c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729bd30>, '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 0x1070fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.2rap4uRDWb/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.IwRL97s1tH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 03:07:44 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 03:07:44 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 03:07:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rap4uRDWb/Render', 03:07:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:44 INFO - 'HOME': '/Users/cltbld', 03:07:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:44 INFO - 'LOGNAME': 'cltbld', 03:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:44 INFO - 'MOZ_NO_REMOTE': '1', 03:07:44 INFO - 'NO_EM_RESTART': '1', 03:07:44 INFO - 'PAGER': '/bin/cat', 03:07:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:44 INFO - 'PWD': '/builds/slave/test', 03:07:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:44 INFO - 'SHELL': '/bin/bash', 03:07:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IwRL97s1tH/Listeners', 03:07:44 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 03:07:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:44 INFO - 'USER': 'cltbld', 03:07:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:44 INFO - 'XPC_FLAGS': '0x0', 03:07:44 INFO - 'XPC_SERVICE_NAME': '0', 03:07:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:44 INFO - Downloading/unpacking jsonschema 03:07:44 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 03:07:44 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 03:07:44 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 03:07:44 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 03:07:44 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 03:07:44 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 03:07:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:07:46 INFO - Downloading/unpacking functools32 (from jsonschema) 03:07:46 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 03:07:46 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 03:07:46 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 03:07:46 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 03:07:46 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 03:07:46 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 03:07:47 INFO - Downloading functools32-3.2.3-2.tar.gz 03:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:07:47 INFO - warning: no files found matching '*.txt' 03:07:47 INFO - no previously-included directories found matching 'build' 03:07:47 INFO - no previously-included directories found matching 'dist' 03:07:47 INFO - no previously-included directories found matching '.git*' 03:07:47 INFO - Installing collected packages: jsonschema, functools32 03:07:47 INFO - Running setup.py install for functools32 03:07:47 INFO - warning: no files found matching '*.txt' 03:07:47 INFO - no previously-included directories found matching 'build' 03:07:47 INFO - no previously-included directories found matching 'dist' 03:07:47 INFO - no previously-included directories found matching '.git*' 03:07:47 INFO - Successfully installed jsonschema functools32 03:07:47 INFO - Cleaning up... 03:07:47 INFO - Return code: 0 03:07:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:47 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 0x1073f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3b564c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10729bd30>, '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 0x1070fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.2rap4uRDWb/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.IwRL97s1tH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 03:07:47 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 03:07:47 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 03:07:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rap4uRDWb/Render', 03:07:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:47 INFO - 'HOME': '/Users/cltbld', 03:07:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:47 INFO - 'LOGNAME': 'cltbld', 03:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:47 INFO - 'MOZ_NO_REMOTE': '1', 03:07:47 INFO - 'NO_EM_RESTART': '1', 03:07:47 INFO - 'PAGER': '/bin/cat', 03:07:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:47 INFO - 'PWD': '/builds/slave/test', 03:07:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:47 INFO - 'SHELL': '/bin/bash', 03:07:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IwRL97s1tH/Listeners', 03:07:47 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 03:07:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:47 INFO - 'USER': 'cltbld', 03:07:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:47 INFO - 'XPC_FLAGS': '0x0', 03:07:47 INFO - 'XPC_SERVICE_NAME': '0', 03:07:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:47 INFO - Downloading/unpacking flake8 03:07:47 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 03:07:47 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 03:07:47 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 03:07:47 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 03:07:47 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 03:07:47 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 03:07:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:07:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:07:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:07:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:07:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:07:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:07:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:07:51 INFO - no previously-included directories found matching 'docs/_build' 03:07:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:07:51 INFO - Running setup.py install for pep8 03:07:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:07:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:07:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:07:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:07:51 INFO - no previously-included directories found matching 'docs/_build' 03:07:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:07:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:07:51 INFO - Cleaning up... 03:07:51 INFO - Return code: 0 03:07:51 INFO - Running post-action listener: _resource_record_post_action 03:07:51 INFO - Running post-action listener: _start_resource_monitoring 03:07:51 INFO - Starting resource monitoring. 03:07:51 INFO - ##### 03:07:51 INFO - ##### Running install step. 03:07:51 INFO - ##### 03:07:51 INFO - Running pre-action listener: _resource_record_pre_action 03:07:51 INFO - Running main action method: install 03:07:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:51 INFO - Reading from file tmpfile_stdout 03:07:51 INFO - Detecting whether we're running mozinstall >=1.0... 03:07:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:07:52 INFO - Reading from file tmpfile_stdout 03:07:52 INFO - Output received: 03:07:52 INFO - Usage: mozinstall [options] installer 03:07:52 INFO - Options: 03:07:52 INFO - -h, --help show this help message and exit 03:07:52 INFO - -d DEST, --destination=DEST 03:07:52 INFO - Directory to install application into. [default: 03:07:52 INFO - "/builds/slave/test"] 03:07:52 INFO - --app=APP Application being installed. [default: firefox] 03:07:52 INFO - mkdir: /builds/slave/test/build/application 03:07:52 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'] 03:07:52 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 03:08:26 INFO - Reading from file tmpfile_stdout 03:08:26 INFO - Output received: 03:08:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:08:26 INFO - Running post-action listener: _resource_record_post_action 03:08:26 INFO - ##### 03:08:26 INFO - ##### Running run-tests step. 03:08:26 INFO - ##### 03:08:26 INFO - Running pre-action listener: _resource_record_pre_action 03:08:26 INFO - Running main action method: run_tests 03:08:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:08:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:08:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:08:26 INFO - 2016-01-29 03:08:26.645 screenresolution[2306:33950] starting screenresolution argv=screenresolution get 03:08:26 INFO - 2016-01-29 03:08:26.648 screenresolution[2306:33950] Display 0: 1600x1200x32@60 03:08:26 INFO - 2016-01-29 03:08:26.654 screenresolution[2307:33952] starting screenresolution argv=screenresolution list 03:08:26 INFO - Available Modes on Display 0 03:08:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:08:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:08:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:08:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:08:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:08:26 INFO - Intel Iris: 03:08:26 INFO - Chipset Model: Intel Iris 03:08:26 INFO - Type: GPU 03:08:26 INFO - Bus: Built-In 03:08:26 INFO - VRAM (Dynamic, Max): 1536 MB 03:08:26 INFO - Vendor: Intel (0x8086) 03:08:26 INFO - Device ID: 0x0a2e 03:08:26 INFO - Revision ID: 0x0009 03:08:26 INFO - Displays: 03:08:26 INFO - Display: 03:08:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:08:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:08:26 INFO - Display Serial Number: 1600x1200 60 03:08:26 INFO - Main Display: Yes 03:08:26 INFO - Mirror: Off 03:08:26 INFO - Online: Yes 03:08:26 INFO - Rotation: Supported 03:08:26 INFO - Return code: 0 03:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:08:26 INFO - Python 2.7.3 03:08:26 INFO - Return code: 0 03:08:26 INFO - grabbing minidump binary from tooltool 03:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:26 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 0x10729bd30>, '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 0x1070fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:08:26 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 03:08:26 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 03:08:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:08:26 INFO - Return code: 0 03:08:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:08:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:08:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:08:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:08:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:08:28 INFO - Return code: 0 03:08:28 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/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 03:08:28 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/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0082 --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 03:08:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rap4uRDWb/Render', 03:08:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:08:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:08:28 INFO - 'HOME': '/Users/cltbld', 03:08:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:08:28 INFO - 'LOGNAME': 'cltbld', 03:08:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:08:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:28 INFO - 'MOZ_NO_REMOTE': '1', 03:08:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:08:28 INFO - 'NO_EM_RESTART': '1', 03:08:28 INFO - 'PAGER': '/bin/cat', 03:08:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:28 INFO - 'PWD': '/builds/slave/test', 03:08:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:08:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:08:28 INFO - 'SHELL': '/bin/bash', 03:08:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IwRL97s1tH/Listeners', 03:08:28 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 03:08:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:08:28 INFO - 'USER': 'cltbld', 03:08:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:08:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:28 INFO - 'XPC_FLAGS': '0x0', 03:08:28 INFO - 'XPC_SERVICE_NAME': '0', 03:08:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:08:28 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/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 03:08:28 INFO - mozversion application_buildid: 20160129021926 03:08:28 INFO - mozversion application_changeset: 0ae6c7e277af505c6b13f8ba97e5618b0e8ffdfc 03:08:28 INFO - mozversion application_display_name: Nightly 03:08:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:08:28 INFO - mozversion application_name: Firefox 03:08:28 INFO - mozversion application_remotingname: firefox 03:08:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:08:28 INFO - mozversion application_vendor: Mozilla 03:08:28 INFO - mozversion application_version: 47.0a1 03:08:28 INFO - mozversion platform_buildid: 20160129021926 03:08:28 INFO - mozversion platform_changeset: 0ae6c7e277af505c6b13f8ba97e5618b0e8ffdfc 03:08:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:08:28 INFO - mozversion platform_version: 47.0a1 03:08:28 INFO - using testdate: 1454065708 03:08:28 INFO - actual date: 1454065708 03:08:28 INFO - starting webserver on 'localhost:51193' 03:08:28 INFO - SUITE-START | Running 2 tests 03:08:28 INFO - TEST-START | dromaeo_css 03:08:28 INFO - operating with platform_type : mac_ 03:08:28 INFO - Initialising browser for dromaeo_css test... 03:08:28 INFO - TEST-INFO | started process 2325 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpU_hpug/profile http://localhost:51193/getInfo.html) 03:08:31 INFO - PROCESS | 2325 | __metrics Screen width/height:1600/1200 03:08:31 INFO - PROCESS | 2325 | colorDepth:24 03:08:31 INFO - PROCESS | 2325 | Browser inner width/height: 1024/689 03:08:31 INFO - PROCESS | 2325 | __metrics 03:08:31 INFO - PROCESS | 2325 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:08:32 INFO - TEST-INFO | 2325: exit 0 03:08:32 INFO - Browser initialized. 03:08:32 INFO - Running cycle 1/1 for dromaeo_css test... 03:08:32 INFO - TEST-INFO | started process 2329 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpU_hpug/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:44 INFO - PROCESS | 2329 | RSS: Main: 256520192 03:08:44 INFO - PROCESS | 2329 | 03:09:34 INFO - PROCESS | 2329 | 1454065774312 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] 03:11:43 INFO - PROCESS | 2329 | Cycle 1(1): loaded http://localhost:51193/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51193/tests/dromaeo/cssquery-ext.html) 03:11:44 INFO - PROCESS | 2329 | RSS: Main: 270409728 03:11:44 INFO - PROCESS | 2329 | 03:14:47 INFO - PROCESS | 2329 | Cycle 1(1): loaded http://localhost:51193/tests/dromaeo/cssquery-ext.html (next: http://localhost:51193/tests/dromaeo/cssquery-jquery.html) 03:14:47 INFO - PROCESS | 2329 | RSS: Main: 281505792 03:14:47 INFO - PROCESS | 2329 | 03:17:49 INFO - PROCESS | 2329 | Cycle 1(1): loaded http://localhost:51193/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51193/tests/dromaeo/cssquery-mootools.html) 03:17:49 INFO - PROCESS | 2329 | RSS: Main: 284282880 03:17:49 INFO - PROCESS | 2329 | 03:20:51 INFO - PROCESS | 2329 | Cycle 1(1): loaded http://localhost:51193/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51193/tests/dromaeo/cssquery-prototype.html) 03:20:52 INFO - PROCESS | 2329 | RSS: Main: 285171712 03:20:52 INFO - PROCESS | 2329 | 03:23:54 INFO - PROCESS | 2329 | Cycle 1(1): loaded http://localhost:51193/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51193/tests/dromaeo/cssquery-yui.html) 03:23:55 INFO - PROCESS | 2329 | RSS: Main: 288755712 03:23:55 INFO - PROCESS | 2329 | 03:26:58 INFO - PROCESS | 2329 | Cycle 1(1): loaded http://localhost:51193/tests/dromaeo/cssquery-yui.html (next: http://localhost:51193/tests/dromaeo/cssquery-dojo.html) 03:26:58 INFO - PROCESS | 2329 | RSS: Main: 290119680 03:26:58 INFO - PROCESS | 2329 | 03:26:58 INFO - PROCESS | 2329 | __start_tp_report 03:26:58 INFO - PROCESS | 2329 | _x_x_mozilla_page_load 03:26:58 INFO - PROCESS | 2329 | _x_x_mozilla_page_load_details 03:26:58 INFO - PROCESS | 2329 | |i|pagename|runs| 03:26:58 INFO - PROCESS | 2329 | |0;dojo.html;3139.2308884323343;3463.3765922134007;3500.1074725944914;3511.5961664408583;3536.6109727929925;5479.972600136999;5526.668399896004;5540.196671482632;5540.584456165789;5543.417941116185;5460.153676180188;5559.58303127266;5578.581606379527;5604.41153678864;5670.177824215497;5093.26147708583;5129.6409251352425;5140.920406714595;5150.974245128769;5196.376434827807;127.73010426223195;5089.847304580869;5101.132807422747;5182;5250.212468129773;3989.5611482736876;5002.274670172823;5054.747262636872;5065.6200784941275;5074.4925507449325;5077.619178561623;5108.157154069574;5122.129238029506;5144.43411224765;5174.301469301634;5017.422996355429;5050.772715227824;5080.263361812516;5124.897502049938;5151.17581187012;5354.27717258169;5363.141897296453;5366.221897824794;5408.5402740766685;5498.477644623755;6075.392460753889;6123.387661233885;6130.509559235251;6138;6154;6061.212042434456;6117.27937334216;6142.989934931896;6215.689215539205;6228.22147231596;5684.374718780889;5685.061964775807;5692.402297758758;5706.172604972297;5735.569832262597;6243.843903902348;6244.968775156095;6258.311585725566;6261.154744109578;6273.404026617464;5812.94187058124;6001.7599296027665;6002.309734380602;6051.939480605138;6055.2430946131735;5055.9241611375855;5170.482951704875;5450.018996580654;5823.126531020296;6133.815985520441;6103.633781973096;6111.633302001894;6113.419225173601;6116.908246376308;6118.357572454828;5988.401159883977;6062.727177277033;6105.633661980295;6112.746658179578;6122.7857025004805;4802.807887684454;4841.225403935424;4850.5149485051215;4863.610911127102;4896.436909755353;4190.706650534495;4344.283193273074;4359.80380882861;4365.628921541705;4447.533009034069;5751.741171647286;5767.913481297784;5784.045632470596;5810.651360918274;5888.057910734347;6088.726007329681;6103.84740381494;6112.572119951561;6117.357677443804;6144.8771024579255;5584.720763961785;5588.910162518351;5841.269841269841;5845.006348920694;5853.356130825606;5265.210218467184;5285.814996475105;5291.285676433709;5303.178007408857;5348;6300.905486417708;6315.589486683442;6315.621062736159;6324.683765811783;6333.96833015832;6008.218931538872;6111.865232675556;6117.602355846856;6154.507639388928;6174.197354344086;6312.589681670676;6316.7473301069285;6339.524535659936;6340;6341.778037768656;6085.574009819447;6095.420935011167;6107.938920610737;6111.96944015277;6125.724342404692;6074.179985701874;6117.265928088658;6137.693115344304;6151.630902145706;6159.72281247336;4374.059577190792;5156.535911767959;5996.310424301261;6010.789622363196;6013.398660133952;5981.401859813984;5982.760689572368;5990.191324171181;6012.428819262163;6022.488088512526;5712.714364281686;5787.913181302368;5840.357560668238;5848.093545500455;5939;5293.417724050429;6040.697965101639;6059.272887253558;6059.697015149313;6068.848278793065;5789.797357092481;5882.49998750111;5882.5293976482635;5895.4399332063385;5904.3210030847 03:26:58 INFO - PROCESS | 2329 | |1;ext.html;412.7420362273577;458.71788849857325;482.8696252011957;536.5412572250727;562.6511562831046;33847.661523384755;37048.814755926185;37174.62825371749;37180.256394872085;37293.627063729386;39449.408258876065;39675.603243967555;39973;40046.79976600113;40115.598844011554;9278.628854845814;9387;9451.952740236324;9452.905470945272;9497.857532137023;9386.436813791195;9515.762105947371;9529;9581.952090239574;9628.855567166498;9594.280428967855;9679.467629280387;9685.079917407835;9714.125728684417;9717.611295548206;9559.569819358145;9602.087801658901;9620.374675646131;9652.179564737005;9678.661246856327;9495.66765163223;9530.18993385563;9596.472194029326;9601.759956001086;9629.422234665943;38502.42246366307;38822.611773882185;38867;38985.610143898484;39122.413163802565;2492.987535062331;3068.6804673990177;3168.8098714077228;3247.220667039917;3330.550375699274;27241.86379068092;27987.44025119486;28481.715182848115;28919.132426027252;29471.41057178866;2583.7287084856007;2634;2730.8088433809444;2735.0564055400855;2784.2621705248125;360620;361395;361452;361619;361863;50642.24036639454;52513.6871578206;54320.185197222076;54580.18129728057;55292.72353638206;52246;54363;55571.72214138904;63741.36258637354;63900;15988.920055399649;16016.279267432994;16162;16202.75695864563;16220.107894065704;12446.937765311115;12509.124361294804;12527.310997895203;12534.81197782034;12544.81182782259;18592.25630974773;18867.81132188688;18901.810981890005;18921.337753178574;18947.147378367732;7576.3181313682035;7736.613169341623;7748.34139098183;7766.223377662189;7769.883451748228;825.7027470110755;955.498363359228;971.5967873332629;973.0561355485167;987.7283746969641;21968.01143948526;29270;29276.560851587245;29345.706542934724;29880.55179172314;1004.4324956399611;1036.2487396300228;1186.3178672263482;1198.2930071257824;1202.9534305154398;13042.608721738363;15068.623284417758;15234;15448.459303924308;15743.68512629741;655141;664151;664194;664766;665974;57678.4232157673;57722.4227757717;58157;58474.7076264616;58900.1164982517;1319.8218240537406;1385.7436374270792;1416.3060100550656;1421.2396367943309;1443.8483959184343;29659.96190133335;29900.401991959603;30076;30565;30817.383652327277;50972.490275096774;51057;51583;51701.48298516967;51764.70588235324;321560;428084;431431;432976;434068;40166.995825104605;41422.58577414308;42732;42761.358579621956;42849.92875178145;35397;39399;40356.1928761429;41061.58938410578;41282.587174127875;33520.49719254165;34826.9551913443;35025.64974350326;35140.29719405649;35289;33922.66077339195;34136.82931585326;34610.75030123135;34835.303293934485;35016;34406.483902740976;34679.13302167466;34713.479297810045;34863.9540813776;34868.82565587156;32252.516212256367;32394.190145246557;32441.51337729983;32443.837780810944;33202.667973319956;21654.67517987263;22668.773312266665;23928.521429571658;24252;25003.87498062498 03:26:58 INFO - PROCESS | 2329 | |2;jquery.html;361.21976530693723;366.97981611011386;369.58606360875814;371.6190904323067;375.7933136774774;15213.315400806963;18070.72893906591;18426.631467370677;18739.625207495843;19482;9259.490728009956;11904.7619047619;14908.850911490908;19073.237070517163;19157.904210478962;3936.1734035852364;4050.473438452997;5297.046531624306;5336.17289320156;5354.759035843377;4029.375446805735;5717.742701578418;5875.2949646042325;5882.705864706769;5964.821055368346;5863.296404431453;5905.173275741399;6524.086627872078;6550.901736473957;6557.868842623145;5563.805266815682;6265.154204182422;6492.188476440445;6531.412172904437;6542.836429089263;4889.413270407574;5451.400345961981;5722.141678748179;5752.741126649311;5819.098039803837;23863.880680596485;23961.88019059911;24066.03735850564;24318.756812431828;24355.391115222083;2065.617860695761;2219.4895174109884;2242.4169715873827;2373.8931748071204;2824.6751623563346;8561.529115898624;8981.955090224572;9908.009199080107;10008.449535275557;10100.78790545132;1728.7234042553257;1772.5745821002865;1794.4168145352683;1847.2313850763235;1871.2140900821687;96912.51543742306;99140;100036.99926001512;100156.49921750344;102013.46979795383;11063.446827658585;11339.829902551468;11438.542458301576;11441.370724610226;11494.54021839117;12905.96752259817;13544.322783860966;13555.525556605471;13586.524471643444;13621.863781362059;8295.502269863828;8461.196186362286;8537.871931921027;8552.401331906707;8584.91415085841;8436.02985656645;8525.14748525155;8622.741317760478;8651.04838467768;8686.261667758312;3583.6595523425235;3983.701222408273;4271.231178387858;4415.072834704748;4499.865004049884;1876.3807943378652;1931.72506145943;1957.9412617621495;1973.7631484221986;1977.8022197780394;850.9914900851036;857.6397912876607;971.9805603887883;1016.703702778948;1082.4912291223113;17784.91107544454;18586.975985356417;18653.533661658297;18691.813081869008;18791.718124228148;858.3905427146796;925.8009527951523;977.8127036073697;1032.912202462784;1036.43514284715;9730.36752611078;10374.533146008447;10544.05103540685;10570.41862697559;10583;277232;541536;583791;588268;597686;113608;115602;115913;118328;120448;1136.0968030415838;1177.1995043370591;1182.751622159339;1186.6736647422028;1192.546832203757;17522.649547009245;17562.560935976704;17634.1182940855;17654.646907062044;17913.552161195552;50400;51444.48555514547;51614.48385516247;52173.7391313041;52473.737631313124;65653;68026.319736802;68186;68571;68619;7556.508826926232;7662.425318101276;7704.152543220129;7731.845363092594;7760.650770715444;10287.691369258935;11290.266132701676;11701.888320609529;11755.647330580096;11992;8012.799680008046;8593.742187734379;9564.713058608253;9650.565724542554;9826.722526071564;8858.867116993122;9967.700968970943;9967.950160249153;10049.69850904474;10458.320209186379;10266.794664106825;10318.380897145895;10342.741431463972;10491.213159012952;10516.57933682644;7516.022917020752;7528.661210245662;7609.429292803173;7617.885731713918;7718.807029824075;10025.097741203326;10346.586136554453;10380.06579407857;10576.41829699374;10588.311759735592 03:26:58 INFO - PROCESS | 2329 | |3;mootools.html;1377.380178919486;1541.6145963509123;1546.4741987724178;1843.3456123076307;1865.4030710172751;7858.174891636368;7918.802029949255;8639.956800215998;8798.868016979743;8811;7130.893036604442;8321.791955201108;8387.748367548968;8460;8533.573321333939;2461.310832966772;2463.8768061596893;2482.900683972648;2491.4394261291245;2492.2149522900227;2422.563938491071;2486.8259221854387;2489.9128530501434;2498.7386415294186;2502.3744063984004;2453.9386515337083;2490.3649569359786;2500.762427569378;2507.1601013660356;2511.7362676918933;2248.325502349297;2269.4326418395403;2459.557279689655;2496.0889275414524;2499.450120973383;2452.546278938384;2479.4917042006527;2486.3038349262238;2489.2283392148493;2513.3339664988794;8687.565621718952;8733.214010739064;8754.299656027502;8756.299496040301;8784.868226976601;5355.866103347408;5485.6982865942355;5507.118860982224;5514;5514.80698175566;3615.7649752765988;3702.9629703702885;3740.989932718151;3747.9437808432895;3760.905977350561;1049.2340591368343;1066.3228849680509;1066.5040756048475;1102.1403305421784;1106.2311693373108;11595.94202028993;11856.644300670994;11919.642410727605;11974.88025119755;11987.760244795143;4884.755762211875;4904.852854414374;4914.238293064581;4959.801607935642;4976.2038073908;10084.69745907624;10116.74708132288;10142.036506531867;10165.237607179492;10165.796684066278;5416.91874621881;5457.426970168154;5483.314585676791;5487.533559647395;5500.917486237709;4436.112777444524;4567.132244873464;4874.46380898101;4917.9016419672125;4937.925931111036;3348.5646865907765;3946.605339466088;4009.178118485762;4017.216642754693;4024.436578878901;1310.8033794930836;1322.24631959782;1326.562234462625;1336.993315033438;1346.9259190744604;1053.8735351757684;1079.7246702090918;1120.3054106453887;1295.184034058537;1298.441670081855;7835.059792824897;7913.208679132041;8071.394645401619;8072.394570407126;8077.838443231102;493.0828658694825;502.0285747079413;517.7540668182584;520.9296744939461;523.7800123947951;6143.109249158847;6177.660228687376;6202.534809889276;6231.9688401557705;6280.183576135073;10285.640002599874;10563.524641391155;10569.101626361691;10591.417472039111;10678.412687302272;10451.84322235167;10487.161027117812;10505.842412363821;10517.52671129801;10606.681799546026;6787.830304242335;8075.3539716822515;8166.510009399455;8183.631736571869;8242.752717418487;7601.923980760122;7671.38628909697;7679.347255483346;7699.615019249127;7741;8031.959840200761;8322.20939010793;9306.813863722824;9466.81664791901;9467.053294670477;9553.90446095558;9673;9755.463449510346;9875.20998320147;9979.650712225037;6774.288699686462;6951.409130223988;7303;7480.513766605153;7529.284717951786;8122.39082068859;8147.9185208147155;8166.4283500154415;8189.426740128134;8193.46742461738;7514.1358743742985;7592.126905405949;7598.810029749079;7788.221177882167;7798.025246844145;7470.0662417197855;7472.36484898768;7500.662470188964;7524.623768811428;7619.352355049661;7585.393168546613;7623.695052198072;7646;7652.005239318853;7656.693732250647;6814.965925170342;6887.414569761627;6914.4468442525485;6932.168139823253;6947.756828510978;6990.510664253454;6991.2309645937885;7053.1536215652395;7067;7080.964595176991 03:26:58 INFO - PROCESS | 2329 | |4;prototype.html;267.64002416749463;311.5513660329126;337.82264311236605;339.77405025657924;340.9045467269166;5456.836294911149;6537.803865884025;6584.14406127204;6707.966460167704;6757.729690812368;5541.390447050821;6255.843603909893;6305.905411418832;6548.803535893919;6564.146660934072;4907.705537667752;4922.950770492303;4928.507149285061;4932.654714170009;4937.481564435737;4901.411830580335;4913.26301054841;4918.434380046287;4919;4934.975325123387;4680.3681502997;4804.1352556539805;4832.565069143777;4833.3958255218095;4858.5627293543575;4807.927881081769;4822.107910036654;4848.224284114524;4859.028194361124;4873.074115918;3925.391564307537;4010.1578668479656;4100.958990410088;4105.5894410559;4139.523954745213;6237.1891654084675;6332.746690132389;6347.047942808569;6403.455706264973;6434.646094464802;5682.40334764852;5689.459501347365;5698.40166782486;5724.542036637059;5729.1119876419225;6837.487188460886;7075.0448689426785;7091.964540177266;7099.680514376865;7112.0754301940415;4229.625371754161;4270.636995855356;4629.120467111272;4637.536246375369;4644.558766917137;7418.443616728767;7456.067991501062;7479.551226926347;7516.173220945691;7519.661615227274;4652.720836749738;4666.78999445019;4667.579917807414;4668.85993420198;4693.319468677023;3744.307303148926;4593.173228818778;4735.100330937111;4761.738104404221;4774.140654682121;5674.148877668383;5682.744276507485;5699.74351154199;5709.8287051388525;5745.9712701437065;5820.447057529528;7127.786166415016;7142.107236595426;7161.856762864713;7163.89254161188;1629.2342598978462;1647.5633957001405;1668.8414600612923;1672.2140593920838;1672.882898197139;1059.814532456817;1065.8861489743238;1071.9410432426291;1073.350622873166;1080.9621663241749;5574.9442505574425;6839.247682754893;6848.828779280558;6855.691493882788;6873.312668733087;7409.296116868889;7419.2209817969415;7433.256674332523;7433.628318584049;7437.293457121565;6645.169353830771;6854.280300568468;6859.348361905611;6865.519413641097;6919.515633905679;3140.5760222370145;3523.841427135785;3904.1801221743754;3927.489426374553;3939.5863434339553;7799.220077992269;7813.492123011986;7934.563599001995;7951.125376208613;7956.801079973047;7660.502067365604;7691.038620172479;7694.307512323918;7704.768856934301;7711.807204819812;7704.075510938723;7893.868655462993;7915;7920.366370690331;7923.801904952422;6513.804585862432;6705.362990515893;7415.962920185365;7428.1086269647985;7480.625968701652;6570.310117437792;6619.602823830585;7301.269873012656;7301.452391070798;7319.5242309249725;7620.161782203842;7917.881231781643;7922.881156782538;7961.920380796118;7962.203779622223;4722.386089808303;4742.454617719007;4748.596369308648;4759.7858096386435;4763.69036012658;7108.9289107110335;7393.408527317694;7400.296971787671;7408.555486670817;7424.220456851953;5862.768818548153;7117.181524124792;7144.106986626672;7157.498975071695;7158;7109.111361079865;7143.249958754256;7150.606716630636;7160.856782864418;7165.104361954755;5807.680577568274;6451.8064458064455;6649.63427011519;6833.58998460094;7056.823579410556;5463.863403414787;7163.6060016699585;7174.497785155198;7175.425965922818;7182.856342873218;6998.16022077354;7003;7022.754203602849;7031.191412987572;7055.541389809646 03:26:58 INFO - PROCESS | 2329 | |5;yui.html;715.549204001479;716.2837162837163;723.7901008707476;732.1799584465398;742.8528923160845;14779.482718104868;15016.174110423923;15117.470888518905;15125.016873903189;15166.317515711791;13815.309234538283;13871.930640346809;14017.50938717145;14020.509282175126;14147.009709320351;693.3690341788973;703.8416356319839;832.388194676912;836.9832603347929;840.4369072721261;682.3756263019332;773.234497847133;835.5822088955522;838.2958315015386;856.5588721808274;883.4964070479829;888.1251966812684;895.3956079646246;898.9775255618597;900.9909900900973;884.5444596033049;888.3515034025198;892.4065496444856;894.1416240409214;899.0290486274807;644.9000404937242;656.1371796088176;661.318841593155;661.751843058853;664.5447868210291;14597.197154156516;14676.04605700626;14698.11811291326;14811.481598144013;14811.703765924622;12635.74728505434;12712.936435317857;12725.74548509034;12760.553380631633;13096.934515327363;10385.169186465064;10410.854805971338;10443.68668939933;10491.527881245362;10685.35887846724;3708.332500149972;4045.5638248421683;4092.5062352241216;4187.267228235077;4207.284761590537;78704.60647696782;80251.59874200591;80316.19683803145;80750;81080.59459702723;9311.48786816718;9371.718848434557;9483.90516094844;9564.091411315914;9579.377340472847;20237.19051237934;20460.488487787923;20497.692534611993;20503.794962050488;20565.58868822615;7103.289671032855;7187.56874587516;7261;7336.339729424378;7356.632168391559;3898.6101389860787;3976.5228172619472;3977.284088864032;3987.4018897165656;4026.959730402717;3366.983165084159;3367.865285388606;3399.2351720862607;3405;3405.7058317839064;543.8450041738085;650.8633187030777;651.1925212736173;670.410039165541;672.3108813466237;488.42609933328197;535.526059437393;573.6758731316876;584.9766009359578;600.9819705408845;8623.764305088625;8631.741047768577;8644.135586441305;8726;9040.231580315616;519.9974000129976;537.9946200538022;593.9881202375929;604.283923550594;615.1572345886165;4019.376996565537;4037.818298176589;4114.259433302034;4187.120704651997;4263.509696384894;93359;94726;95957.0404295962;96331;96941;57110.714446427504;57922.42077579255;70507.6474617634;70825.58348833097;80991.59504202442;44168.3374749379;49123;62936.741265175355;66767;68796.31203687999;8968.327375446997;8968.641254350014;9005.504697241715;9143.908560914571;9166.22087122602;36459.27081458409;47769;48732.51267487422;48757.5124248753;49422.752886235336;51086.489135108175;66031.33968660443;67036;68215.65892170508;68804;10757.230097929074;10942.890571094187;11468.483918223534;11550.82673759911;11807.232529885874;11965.76068478608;12345.581560563829;12415.255084694947;12421.130520863453;12424.875751242373;11224.10207183407;11484.655460336204;11831.940840296087;11946.223495472766;12449.502019919464;11312.886871131182;11811.232269902428;11935.52257909674;12006.519739210335;12391.814122788346;10903.473513707928;11450.370229637118;11592.6522204334;11651.12616553745;12123.81814272769;9334.299927505328;9412.67055653049;9648.372855764354;9732.951335243279;9746;8369.707060252862;9299.628014879328;9946.204303655546;9959.502024898582;10061.798764024532 03:26:58 INFO - PROCESS | 2329 | __end_tp_report 03:26:58 INFO - PROCESS | 2329 | __start_cc_report 03:26:58 INFO - PROCESS | 2329 | _x_x_mozilla_cycle_collect,356 03:26:58 INFO - PROCESS | 2329 | __end_cc_report 03:26:58 INFO - PROCESS | 2329 | __startTimestamp1454066818336__endTimestamp 03:26:58 INFO - PROCESS | 2329 | 03:26:58 INFO - PROCESS | 2329 | ------- Summary: start ------- 03:26:58 INFO - PROCESS | 2329 | Number of tests: 6 03:26:58 INFO - PROCESS | 2329 | 03:26:58 INFO - PROCESS | 2329 | [#0] dojo.html Cycles:165 Average:5589.64 Median:5840.36 stddev:772.96 (13.2%) stddev-sans-first:751.04 03:26:58 INFO - PROCESS | 2329 | Values: 3139.2 3463.4 3500.1 3511.6 3536.6 5480.0 5526.7 5540.2 5540.6 5543.4 5460.2 5559.6 5578.6 5604.4 5670.2 5093.3 5129.6 5140.9 5151.0 5196.4 127.7 5089.8 5101.1 5182.0 5250.2 3989.6 5002.3 5054.7 5065.6 5074.5 5077.6 5108.2 5122.1 5144.4 5174.3 5017.4 5050.8 5080.3 5124.9 5151.2 5354.3 5363.1 5366.2 5408.5 5498.5 6075.4 6123.4 6130.5 6138.0 6154.0 6061.2 6117.3 6143.0 6215.7 6228.2 5684.4 5685.1 5692.4 5706.2 5735.6 6243.8 6245.0 6258.3 6261.2 6273.4 5812.9 6001.8 6002.3 6051.9 6055.2 5055.9 5170.5 5450.0 5823.1 6133.8 6103.6 6111.6 6113.4 6116.9 6118.4 5988.4 6062.7 6105.6 6112.7 6122.8 4802.8 4841.2 4850.5 4863.6 4896.4 4190.7 4344.3 4359.8 4365.6 4447.5 5751.7 5767.9 5784.0 5810.7 5888.1 6088.7 6103.8 6112.6 6117.4 6144.9 5584.7 5588.9 5841.3 5845.0 5853.4 5265.2 5285.8 5291.3 5303.2 5348.0 6300.9 6315.6 6315.6 6324.7 6334.0 6008.2 6111.9 6117.6 6154.5 6174.2 6312.6 6316.7 6339.5 6340.0 6341.8 6085.6 6095.4 6107.9 6112.0 6125.7 6074.2 6117.3 6137.7 6151.6 6159.7 4374.1 5156.5 5996.3 6010.8 6013.4 5981.4 5982.8 5990.2 6012.4 6022.5 5712.7 5787.9 5840.4 5848.1 5939.0 5293.4 6040.7 6059.3 6059.7 6068.8 5789.8 5882.5 5882.5 5895.4 5904.3 03:26:58 INFO - PROCESS | 2329 | 03:26:58 INFO - PROCESS | 2329 | [#1] ext.html Cycles:180 Average:61828.41 Median:37236.94 stddev:132803.37 (356.6%) stddev-sans-first:133095.86 03:26:58 INFO - PROCESS | 2329 | Values: 412.7 458.7 482.9 536.5 562.7 33847.7 37048.8 37174.6 37180.3 37293.6 39449.4 39675.6 39973.0 40046.8 40115.6 9278.6 9387.0 9452.0 9452.9 9497.9 9386.4 9515.8 9529.0 9582.0 9628.9 9594.3 9679.5 9685.1 9714.1 9717.6 9559.6 9602.1 9620.4 9652.2 9678.7 9495.7 9530.2 9596.5 9601.8 9629.4 38502.4 38822.6 38867.0 38985.6 39122.4 2493.0 3068.7 3168.8 3247.2 3330.6 27241.9 27987.4 28481.7 28919.1 29471.4 2583.7 2634.0 2730.8 2735.1 2784.3 360620.0 361395.0 361452.0 361619.0 361863.0 50642.2 52513.7 54320.2 54580.2 55292.7 52246.0 54363.0 55571.7 63741.4 63900.0 15988.9 16016.3 16162.0 16202.8 16220.1 12446.9 12509.1 12527.3 12534.8 12544.8 18592.3 18867.8 18901.8 18921.3 18947.1 7576.3 7736.6 7748.3 7766.2 7769.9 825.7 955.5 971.6 973.1 987.7 21968.0 29270.0 29276.6 29345.7 29880.6 1004.4 1036.2 1186.3 1198.3 1203.0 13042.6 15068.6 15234.0 15448.5 15743.7 655141.0 664151.0 664194.0 664766.0 665974.0 57678.4 57722.4 58157.0 58474.7 58900.1 1319.8 1385.7 1416.3 1421.2 1443.8 29660.0 29900.4 30076.0 30565.0 30817.4 50972.5 51057.0 51583.0 51701.5 51764.7 321560.0 428084.0 431431.0 432976.0 434068.0 40167.0 41422.6 42732.0 42761.4 42849.9 35397.0 39399.0 40356.2 41061.6 41282.6 33520.5 34827.0 35025.6 35140.3 35289.0 33922.7 34136.8 34610.8 34835.3 35016.0 34406.5 34679.1 34713.5 34864.0 34868.8 32252.5 32394.2 32441.5 32443.8 33202.7 21654.7 22668.8 23928.5 24252.0 25003.9 03:26:58 INFO - PROCESS | 2329 | 03:26:58 INFO - PROCESS | 2329 | [#2] jquery.html Cycles:180 Average:31026.65 Median:1972.44 stddev:88803.70 (4502.2%) stddev-sans-first:89022.97 03:26:58 INFO - PROCESS | 2329 | Values: 361.2 367.0 369.6 371.6 375.8 15213.3 18070.7 18426.6 18739.6 19482.0 9259.5 11904.8 14908.9 19073.2 19157.9 3936.2 4050.5 5297.0 5336.2 5354.8 4029.4 5717.7 5875.3 5882.7 5964.8 5863.3 5905.2 6524.1 6550.9 6557.9 5563.8 6265.2 6492.2 6531.4 6542.8 4889.4 5451.4 5722.1 5752.7 5819.1 23863.9 23961.9 24066.0 24318.8 24355.4 2065.6 2219.5 2242.4 2373.9 2824.7 8561.5 8982.0 9908.0 10008.4 10100.8 1728.7 1772.6 1794.4 1847.2 1871.2 96912.5 99140.0 100037.0 100156.5 102013.5 11063.4 11339.8 11438.5 11441.4 11494.5 12906.0 13544.3 13555.5 13586.5 13621.9 8295.5 8461.2 8537.9 8552.4 8584.9 8436.0 8525.1 8622.7 8651.0 8686.3 3583.7 3983.7 4271.2 4415.1 4499.9 1876.4 1931.7 1957.9 1973.8 1977.8 851.0 857.6 972.0 1016.7 1082.5 17784.9 18587.0 18653.5 18691.8 18791.7 858.4 925.8 977.8 1032.9 1036.4 9730.4 10374.5 10544.1 10570.4 10583.0 277232.0 541536.0 583791.0 588268.0 597686.0 113608.0 115602.0 115913.0 118328.0 120448.0 1136.1 1177.2 1182.8 1186.7 1192.5 17522.6 17562.6 17634.1 17654.6 17913.6 50400.0 51444.5 51614.5 52173.7 52473.7 65653.0 68026.3 68186.0 68571.0 68619.0 7556.5 7662.4 7704.2 7731.8 7760.7 10287.7 11290.3 11701.9 11755.6 11992.0 8012.8 8593.7 9564.7 9650.6 9826.7 8858.9 9967.7 9968.0 10049.7 10458.3 10266.8 10318.4 10342.7 10491.2 10516.6 7516.0 7528.7 7609.4 7617.9 7718.8 10025.1 10346.6 10380.1 10576.4 10588.3 03:26:58 INFO - PROCESS | 2329 | 03:26:58 INFO - PROCESS | 2329 | [#3] mootools.html Cycles:180 Average:5977.69 Median:5386.39 stddev:3148.59 (58.5%) stddev-sans-first:3138.43 03:26:58 INFO - PROCESS | 2329 | Values: 1377.4 1541.6 1546.5 1843.3 1865.4 7858.2 7918.8 8640.0 8798.9 8811.0 7130.9 8321.8 8387.7 8460.0 8533.6 2461.3 2463.9 2482.9 2491.4 2492.2 2422.6 2486.8 2489.9 2498.7 2502.4 2453.9 2490.4 2500.8 2507.2 2511.7 2248.3 2269.4 2459.6 2496.1 2499.5 2452.5 2479.5 2486.3 2489.2 2513.3 8687.6 8733.2 8754.3 8756.3 8784.9 5355.9 5485.7 5507.1 5514.0 5514.8 3615.8 3703.0 3741.0 3747.9 3760.9 1049.2 1066.3 1066.5 1102.1 1106.2 11595.9 11856.6 11919.6 11974.9 11987.8 4884.8 4904.9 4914.2 4959.8 4976.2 10084.7 10116.7 10142.0 10165.2 10165.8 5416.9 5457.4 5483.3 5487.5 5500.9 4436.1 4567.1 4874.5 4917.9 4937.9 3348.6 3946.6 4009.2 4017.2 4024.4 1310.8 1322.2 1326.6 1337.0 1346.9 1053.9 1079.7 1120.3 1295.2 1298.4 7835.1 7913.2 8071.4 8072.4 8077.8 493.1 502.0 517.8 520.9 523.8 6143.1 6177.7 6202.5 6232.0 6280.2 10285.6 10563.5 10569.1 10591.4 10678.4 10451.8 10487.2 10505.8 10517.5 10606.7 6787.8 8075.4 8166.5 8183.6 8242.8 7601.9 7671.4 7679.3 7699.6 7741.0 8032.0 8322.2 9306.8 9466.8 9467.1 9553.9 9673.0 9755.5 9875.2 9979.7 6774.3 6951.4 7303.0 7480.5 7529.3 8122.4 8147.9 8166.4 8189.4 8193.5 7514.1 7592.1 7598.8 7788.2 7798.0 7470.1 7472.4 7500.7 7524.6 7619.4 7585.4 7623.7 7646.0 7652.0 7656.7 6815.0 6887.4 6914.4 6932.2 6947.8 6990.5 6991.2 7053.2 7067.0 7081.0 03:26:58 INFO - PROCESS | 2329 | 03:26:58 INFO - PROCESS | 2329 | [#4] prototype.html Cycles:180 Average:5795.18 Median:6525.80 stddev:1889.60 (29.0%) stddev-sans-first:1848.79 03:26:58 INFO - PROCESS | 2329 | Values: 267.6 311.6 337.8 339.8 340.9 5456.8 6537.8 6584.1 6708.0 6757.7 5541.4 6255.8 6305.9 6548.8 6564.1 4907.7 4923.0 4928.5 4932.7 4937.5 4901.4 4913.3 4918.4 4919.0 4935.0 4680.4 4804.1 4832.6 4833.4 4858.6 4807.9 4822.1 4848.2 4859.0 4873.1 3925.4 4010.2 4101.0 4105.6 4139.5 6237.2 6332.7 6347.0 6403.5 6434.6 5682.4 5689.5 5698.4 5724.5 5729.1 6837.5 7075.0 7092.0 7099.7 7112.1 4229.6 4270.6 4629.1 4637.5 4644.6 7418.4 7456.1 7479.6 7516.2 7519.7 4652.7 4666.8 4667.6 4668.9 4693.3 3744.3 4593.2 4735.1 4761.7 4774.1 5674.1 5682.7 5699.7 5709.8 5746.0 5820.4 7127.8 7142.1 7161.9 7163.9 1629.2 1647.6 1668.8 1672.2 1672.9 1059.8 1065.9 1071.9 1073.4 1081.0 5574.9 6839.2 6848.8 6855.7 6873.3 7409.3 7419.2 7433.3 7433.6 7437.3 6645.2 6854.3 6859.3 6865.5 6919.5 3140.6 3523.8 3904.2 3927.5 3939.6 7799.2 7813.5 7934.6 7951.1 7956.8 7660.5 7691.0 7694.3 7704.8 7711.8 7704.1 7893.9 7915.0 7920.4 7923.8 6513.8 6705.4 7416.0 7428.1 7480.6 6570.3 6619.6 7301.3 7301.5 7319.5 7620.2 7917.9 7922.9 7961.9 7962.2 4722.4 4742.5 4748.6 4759.8 4763.7 7108.9 7393.4 7400.3 7408.6 7424.2 5862.8 7117.2 7144.1 7157.5 7158.0 7109.1 7143.2 7150.6 7160.9 7165.1 5807.7 6451.8 6649.6 6833.6 7056.8 5463.9 7163.6 7174.5 7175.4 7182.9 6998.2 7003.0 7022.8 7031.2 7055.5 03:26:58 INFO - PROCESS | 2329 | 03:26:58 INFO - PROCESS | 2329 | [#5] yui.html Cycles:180 Average:17609.01 Median:29248.05 stddev:24465.11 (83.6%) stddev-sans-first:24500.86 03:26:58 INFO - PROCESS | 2329 | Values: 715.5 716.3 723.8 732.2 742.9 14779.5 15016.2 15117.5 15125.0 15166.3 13815.3 13871.9 14017.5 14020.5 14147.0 693.4 703.8 832.4 837.0 840.4 682.4 773.2 835.6 838.3 856.6 883.5 888.1 895.4 899.0 901.0 884.5 888.4 892.4 894.1 899.0 644.9 656.1 661.3 661.8 664.5 14597.2 14676.0 14698.1 14811.5 14811.7 12635.7 12712.9 12725.7 12760.6 13096.9 10385.2 10410.9 10443.7 10491.5 10685.4 3708.3 4045.6 4092.5 4187.3 4207.3 78704.6 80251.6 80316.2 80750.0 81080.6 9311.5 9371.7 9483.9 9564.1 9579.4 20237.2 20460.5 20497.7 20503.8 20565.6 7103.3 7187.6 7261.0 7336.3 7356.6 3898.6 3976.5 3977.3 3987.4 4027.0 3367.0 3367.9 3399.2 3405.0 3405.7 543.8 650.9 651.2 670.4 672.3 488.4 535.5 573.7 585.0 601.0 8623.8 8631.7 8644.1 8726.0 9040.2 520.0 538.0 594.0 604.3 615.2 4019.4 4037.8 4114.3 4187.1 4263.5 93359.0 94726.0 95957.0 96331.0 96941.0 57110.7 57922.4 70507.6 70825.6 80991.6 44168.3 49123.0 62936.7 66767.0 68796.3 8968.3 8968.6 9005.5 9143.9 9166.2 36459.3 47769.0 48732.5 48757.5 49422.8 51086.5 66031.3 67036.0 68215.7 68804.0 10757.2 10942.9 11468.5 11550.8 11807.2 11965.8 12345.6 12415.3 12421.1 12424.9 11224.1 11484.7 11831.9 11946.2 12449.5 11312.9 11811.2 11935.5 12006.5 12391.8 10903.5 11450.4 11592.7 11651.1 12123.8 9334.3 9412.7 9648.4 9733.0 9746.0 8369.7 9299.6 9946.2 9959.5 10061.8 03:26:58 INFO - PROCESS | 2329 | -------- Summary: end -------- 03:26:58 INFO - PROCESS | 2329 | 03:26:58 INFO - TEST-INFO | 2329: exit 0 03:26:58 INFO - TEST-OK | dromaeo_css | took 1110072ms 03:26:58 INFO - TEST-START | kraken 03:26:58 INFO - operating with platform_type : mac_ 03:26:58 INFO - Initialising browser for kraken test... 03:26:58 INFO - TEST-INFO | started process 2333 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpHPEEnV/profile http://localhost:51193/getInfo.html) 03:27:01 INFO - PROCESS | 2333 | __metrics Screen width/height:1600/1200 03:27:01 INFO - PROCESS | 2333 | colorDepth:24 03:27:01 INFO - PROCESS | 2333 | Browser inner width/height: 1024/689 03:27:01 INFO - PROCESS | 2333 | __metrics 03:27:01 INFO - PROCESS | 2333 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:27:02 INFO - TEST-INFO | 2333: exit 0 03:27:02 INFO - Browser initialized. 03:27:02 INFO - Running cycle 1/1 for kraken test... 03:27:02 INFO - TEST-INFO | started process 2336 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpHPEEnV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:14 INFO - PROCESS | 2336 | RSS: Main: 254816256 03:27:14 INFO - PROCESS | 2336 | 03:27:17 INFO - PROCESS | 2336 | Cycle 1(1): loaded http://localhost:51193/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51193/tests/kraken/driver.html?testName=audio-beat-detection) 03:27:17 INFO - PROCESS | 2336 | RSS: Main: 269762560 03:27:17 INFO - PROCESS | 2336 | 03:27:20 INFO - PROCESS | 2336 | Cycle 1(1): loaded http://localhost:51193/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51193/tests/kraken/driver.html?testName=audio-dft) 03:27:20 INFO - PROCESS | 2336 | RSS: Main: 277078016 03:27:20 INFO - PROCESS | 2336 | 03:27:24 INFO - PROCESS | 2336 | Cycle 1(1): loaded http://localhost:51193/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51193/tests/kraken/driver.html?testName=audio-fft) 03:27:24 INFO - PROCESS | 2336 | RSS: Main: 281608192 03:27:24 INFO - PROCESS | 2336 | 03:27:26 INFO - PROCESS | 2336 | Cycle 1(1): loaded http://localhost:51193/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51193/tests/kraken/driver.html?testName=audio-oscillator) 03:27:27 INFO - PROCESS | 2336 | RSS: Main: 282398720 03:27:27 INFO - PROCESS | 2336 | 03:27:29 INFO - PROCESS | 2336 | Cycle 1(1): loaded http://localhost:51193/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51193/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:27:30 INFO - PROCESS | 2336 | RSS: Main: 284606464 03:27:30 INFO - PROCESS | 2336 | 03:27:32 INFO - PROCESS | 2336 | Cycle 1(1): loaded http://localhost:51193/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51193/tests/kraken/driver.html?testName=imaging-darkroom) 03:27:33 INFO - PROCESS | 2336 | RSS: Main: 283967488 03:27:33 INFO - PROCESS | 2336 | 03:27:36 INFO - PROCESS | 2336 | Cycle 1(1): loaded http://localhost:51193/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51193/tests/kraken/driver.html?testName=imaging-desaturate) 03:27:37 INFO - PROCESS | 2336 | RSS: Main: 283926528 03:27:37 INFO - PROCESS | 2336 | 03:27:39 INFO - PROCESS | 2336 | Cycle 1(1): loaded http://localhost:51193/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51193/tests/kraken/driver.html?testName=json-parse-financial) 03:27:40 INFO - PROCESS | 2336 | RSS: Main: 284618752 03:27:40 INFO - PROCESS | 2336 | 03:27:41 INFO - PROCESS | 2336 | Cycle 1(1): loaded http://localhost:51193/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51193/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:27:42 INFO - PROCESS | 2336 | RSS: Main: 284463104 03:27:42 INFO - PROCESS | 2336 | 03:27:44 INFO - PROCESS | 2336 | Cycle 1(1): loaded http://localhost:51193/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51193/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:27:45 INFO - PROCESS | 2336 | RSS: Main: 282849280 03:27:45 INFO - PROCESS | 2336 | 03:27:47 INFO - PROCESS | 2336 | Cycle 1(1): loaded http://localhost:51193/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51193/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:27:47 INFO - PROCESS | 2336 | RSS: Main: 283693056 03:27:47 INFO - PROCESS | 2336 | 03:27:50 INFO - PROCESS | 2336 | Cycle 1(1): loaded http://localhost:51193/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:27:51 INFO - PROCESS | 2336 | RSS: Main: 282869760 03:27:51 INFO - PROCESS | 2336 | 03:27:53 INFO - PROCESS | 2336 | Cycle 1(1): loaded http://localhost:51193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:27:54 INFO - PROCESS | 2336 | RSS: Main: 283045888 03:27:54 INFO - PROCESS | 2336 | 03:27:55 INFO - PROCESS | 2336 | Cycle 1(1): loaded http://localhost:51193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51193/tests/kraken/driver.html?testName=ai-astar) 03:27:56 INFO - PROCESS | 2336 | RSS: Main: 284790784 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | __start_tp_report 03:27:56 INFO - PROCESS | 2336 | _x_x_mozilla_page_load 03:27:56 INFO - PROCESS | 2336 | _x_x_mozilla_page_load_details 03:27:56 INFO - PROCESS | 2336 | |i|pagename|runs| 03:27:56 INFO - PROCESS | 2336 | |0;ai-astar;117;111;128;155;116;124;111;114;113;114 03:27:56 INFO - PROCESS | 2336 | |1;audio-beat-detection;158;127;153;155;122;143;140;125;152;104 03:27:56 INFO - PROCESS | 2336 | |2;audio-dft;195;202;195;201;203;228;254;204;200;197 03:27:56 INFO - PROCESS | 2336 | |3;audio-fft;65;68;68;79;123;77;82;82;88;63 03:27:56 INFO - PROCESS | 2336 | |4;audio-oscillator;82;87;116;79;83;83;119;97;81;96 03:27:56 INFO - PROCESS | 2336 | |5;imaging-gaussian-blur;77;139;129;95;89;95;89;96;89;94 03:27:56 INFO - PROCESS | 2336 | |6;imaging-darkroom;97;98;98;98;98;97;98;149;99;97 03:27:56 INFO - PROCESS | 2336 | |7;imaging-desaturate;124;96;91;95;91;92;98;91;95;94 03:27:56 INFO - PROCESS | 2336 | |8;json-parse-financial;57;56;57;55;57;55;57;66;56;56 03:27:56 INFO - PROCESS | 2336 | |9;json-stringify-tinderbox;63;64;72;66;69;72;64;65;67;69 03:27:56 INFO - PROCESS | 2336 | |10;stanford-crypto-aes;88;79;104;108;111;108;87;83;83;83 03:27:56 INFO - PROCESS | 2336 | |11;stanford-crypto-ccm;128;133;131;133;133;147;132;127;128;127 03:27:56 INFO - PROCESS | 2336 | |12;stanford-crypto-pbkdf2;141;145;144;136;137;142;145;179;177;133 03:27:56 INFO - PROCESS | 2336 | |13;stanford-crypto-sha256-iterative;67;69;66;66;70;68;67;83;55;65 03:27:56 INFO - PROCESS | 2336 | __end_tp_report 03:27:56 INFO - PROCESS | 2336 | __start_cc_report 03:27:56 INFO - PROCESS | 2336 | _x_x_mozilla_cycle_collect,915 03:27:56 INFO - PROCESS | 2336 | __end_cc_report 03:27:56 INFO - PROCESS | 2336 | __startTimestamp1454066876147__endTimestamp 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | ------- Summary: start ------- 03:27:56 INFO - PROCESS | 2336 | Number of tests: 14 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | [#0] ai-astar Cycles:10 Average:120.30 Median:116.50 stddev:13.38 (11.5%) stddev-sans-first:14.14 03:27:56 INFO - PROCESS | 2336 | Values: 117.0 111.0 128.0 155.0 116.0 124.0 111.0 114.0 113.0 114.0 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:147.50 stddev:17.77 (12.0%) stddev-sans-first:17.29 03:27:56 INFO - PROCESS | 2336 | Values: 158.0 127.0 153.0 155.0 122.0 143.0 140.0 125.0 152.0 104.0 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | [#2] audio-dft Cycles:10 Average:207.90 Median:202.50 stddev:18.75 (9.3%) stddev-sans-first:19.30 03:27:56 INFO - PROCESS | 2336 | Values: 195.0 202.0 195.0 201.0 203.0 228.0 254.0 204.0 200.0 197.0 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | [#3] audio-fft Cycles:10 Average:79.50 Median:78.00 stddev:17.42 (22.3%) stddev-sans-first:17.67 03:27:56 INFO - PROCESS | 2336 | Values: 65.0 68.0 68.0 79.0 123.0 77.0 82.0 82.0 88.0 63.0 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:83.00 stddev:14.61 (17.6%) stddev-sans-first:15.02 03:27:56 INFO - PROCESS | 2336 | Values: 82.0 87.0 116.0 79.0 83.0 83.0 119.0 97.0 81.0 96.0 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | [#5] imaging-gaussian-blur Cycles:10 Average:99.20 Median:91.50 stddev:19.29 (21.1%) stddev-sans-first:18.71 03:27:56 INFO - PROCESS | 2336 | Values: 77.0 139.0 129.0 95.0 89.0 95.0 89.0 96.0 89.0 94.0 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | [#6] imaging-darkroom Cycles:10 Average:102.90 Median:98.00 stddev:16.21 (16.5%) stddev-sans-first:17.05 03:27:56 INFO - PROCESS | 2336 | Values: 97.0 98.0 98.0 98.0 98.0 97.0 98.0 149.0 99.0 97.0 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:94.50 stddev:9.89 (10.5%) stddev-sans-first:2.55 03:27:56 INFO - PROCESS | 2336 | Values: 124.0 96.0 91.0 95.0 91.0 92.0 98.0 91.0 95.0 94.0 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:3.19 (5.6%) stddev-sans-first:3.38 03:27:56 INFO - PROCESS | 2336 | Values: 57.0 56.0 57.0 55.0 57.0 55.0 57.0 66.0 56.0 56.0 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:68.00 stddev:3.28 (4.8%) stddev-sans-first:3.13 03:27:56 INFO - PROCESS | 2336 | Values: 63.0 64.0 72.0 66.0 69.0 72.0 64.0 65.0 67.0 69.0 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | [#10] stanford-crypto-aes Cycles:10 Average:93.40 Median:83.00 stddev:12.69 (15.3%) stddev-sans-first:13.31 03:27:56 INFO - PROCESS | 2336 | Values: 88.0 79.0 104.0 108.0 111.0 108.0 87.0 83.0 83.0 83.0 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:132.50 stddev:5.88 (4.4%) stddev-sans-first:6.06 03:27:56 INFO - PROCESS | 2336 | Values: 128.0 133.0 131.0 133.0 133.0 147.0 132.0 127.0 128.0 127.0 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:144.50 stddev:16.37 (11.3%) stddev-sans-first:17.17 03:27:56 INFO - PROCESS | 2336 | Values: 141.0 145.0 144.0 136.0 137.0 142.0 145.0 179.0 177.0 133.0 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - PROCESS | 2336 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:6.80 (10.1%) stddev-sans-first:7.21 03:27:56 INFO - PROCESS | 2336 | Values: 67.0 69.0 66.0 66.0 70.0 68.0 67.0 83.0 55.0 65.0 03:27:56 INFO - PROCESS | 2336 | -------- Summary: end -------- 03:27:56 INFO - PROCESS | 2336 | 03:27:56 INFO - TEST-INFO | 2336: exit 0 03:27:56 INFO - TEST-OK | kraken | took 58065ms 03:27:56 INFO - SUITE-END | took 1168s 03:27:57 INFO - Completed test suite (00:19:28) 03:27:57 INFO - Working with test: dromaeo_css 03:27:57 INFO - Generating results file: dromaeo_css 03:27:57 INFO - Working with test: kraken 03:27:57 INFO - Generating results file: kraken 03:27:57 INFO - javascript benchmark 03:27:57 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:27:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 03:27:57 INFO - process_Request line: dromaeo_css 7377.98 graph.html#tests=[[72,64,61]] 03:27:57 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:27:57 INFO - process_Request line: kraken 1501.80 graph.html#tests=[[232,64,61]] 03:27:57 INFO - RETURN: dromaeo_css: 7377.98 03:27:57 INFO - RETURN: kraken: 1501.80 03:27:57 INFO - javascript benchmark 03:27:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3139.2308884323343, 3463.3765922134007, 3500.1074725944914, 3511.5961664408583, 3536.6109727929925, 5479.972600136999, 5526.668399896004, 5540.196671482632, 5540.584456165789, 5543.417941116185, 5460.153676180188, 5559.58303127266, 5578.581606379527, 5604.41153678864, 5670.177824215497, 5093.26147708583, 5129.6409251352425, 5140.920406714595, 5150.974245128769, 5196.376434827807, 127.73010426223195, 5089.847304580869, 5101.132807422747, 5182.0, 5250.212468129773, 3989.5611482736876, 5002.274670172823, 5054.747262636872, 5065.6200784941275, 5074.4925507449325, 5077.619178561623, 5108.157154069574, 5122.129238029506, 5144.43411224765, 5174.301469301634, 5017.422996355429, 5050.772715227824, 5080.263361812516, 5124.897502049938, 5151.17581187012, 5354.27717258169, 5363.141897296453, 5366.221897824794, 5408.5402740766685, 5498.477644623755, 6075.392460753889, 6123.387661233885, 6130.509559235251, 6138.0, 6154.0, 6061.212042434456, 6117.27937334216, 6142.989934931896, 6215.689215539205, 6228.22147231596, 5684.374718780889, 5685.061964775807, 5692.402297758758, 5706.172604972297, 5735.569832262597, 6243.843903902348, 6244.968775156095, 6258.311585725566, 6261.154744109578, 6273.404026617464, 5812.94187058124, 6001.7599296027665, 6002.309734380602, 6051.939480605138, 6055.2430946131735, 5055.9241611375855, 5170.482951704875, 5450.018996580654, 5823.126531020296, 6133.815985520441, 6103.633781973096, 6111.633302001894, 6113.419225173601, 6116.908246376308, 6118.357572454828, 5988.401159883977, 6062.727177277033, 6105.633661980295, 6112.746658179578, 6122.7857025004805, 4802.807887684454, 4841.225403935424, 4850.5149485051215, 4863.610911127102, 4896.436909755353, 4190.706650534495, 4344.283193273074, 4359.80380882861, 4365.628921541705, 4447.533009034069, 5751.741171647286, 5767.913481297784, 5784.045632470596, 5810.651360918274, 5888.057910734347, 6088.726007329681, 6103.84740381494, 6112.572119951561, 6117.357677443804, 6144.8771024579255, 5584.720763961785, 5588.910162518351, 5841.269841269841, 5845.006348920694, 5853.356130825606, 5265.210218467184, 5285.814996475105, 5291.285676433709, 5303.178007408857, 5348.0, 6300.905486417708, 6315.589486683442, 6315.621062736159, 6324.683765811783, 6333.96833015832, 6008.218931538872, 6111.865232675556, 6117.602355846856, 6154.507639388928, 6174.197354344086, 6312.589681670676, 6316.7473301069285, 6339.524535659936, 6340.0, 6341.778037768656, 6085.574009819447, 6095.420935011167, 6107.938920610737, 6111.96944015277, 6125.724342404692, 6074.179985701874, 6117.265928088658, 6137.693115344304, 6151.630902145706, 6159.72281247336, 4374.059577190792, 5156.535911767959, 5996.310424301261, 6010.789622363196, 6013.398660133952, 5981.401859813984, 5982.760689572368, 5990.191324171181, 6012.428819262163, 6022.488088512526, 5712.714364281686, 5787.913181302368, 5840.357560668238, 5848.093545500455, 5939.0, 5293.417724050429, 6040.697965101639, 6059.272887253558, 6059.697015149313, 6068.848278793065, 5789.797357092481, 5882.49998750111, 5882.5293976482635, 5895.4399332063385, 5904.3210030847], "unit": "score", "name": "dojo.html", "value": 5544.014279276845}, {"lowerIsBetter": false, "replicates": [412.7420362273577, 458.71788849857325, 482.8696252011957, 536.5412572250727, 562.6511562831046, 33847.661523384755, 37048.814755926185, 37174.62825371749, 37180.256394872085, 37293.627063729386, 39449.408258876065, 39675.603243967555, 39973.0, 40046.79976600113, 40115.598844011554, 9278.628854845814, 9387.0, 9451.952740236324, 9452.905470945272, 9497.857532137023, 9386.436813791195, 9515.762105947371, 9529.0, 9581.952090239574, 9628.855567166498, 9594.280428967855, 9679.467629280387, 9685.079917407835, 9714.125728684417, 9717.611295548206, 9559.569819358145, 9602.087801658901, 9620.374675646131, 9652.179564737005, 9678.661246856327, 9495.66765163223, 9530.18993385563, 9596.472194029326, 9601.759956001086, 9629.422234665943, 38502.42246366307, 38822.611773882185, 38867.0, 38985.610143898484, 39122.413163802565, 2492.987535062331, 3068.6804673990177, 3168.8098714077228, 3247.220667039917, 3330.550375699274, 27241.86379068092, 27987.44025119486, 28481.715182848115, 28919.132426027252, 29471.41057178866, 2583.7287084856007, 2634.0, 2730.8088433809444, 2735.0564055400855, 2784.2621705248125, 360620.0, 361395.0, 361452.0, 361619.0, 361863.0, 50642.24036639454, 52513.6871578206, 54320.185197222076, 54580.18129728057, 55292.72353638206, 52246.0, 54363.0, 55571.72214138904, 63741.36258637354, 63900.0, 15988.920055399649, 16016.279267432994, 16162.0, 16202.75695864563, 16220.107894065704, 12446.937765311115, 12509.124361294804, 12527.310997895203, 12534.81197782034, 12544.81182782259, 18592.25630974773, 18867.81132188688, 18901.810981890005, 18921.337753178574, 18947.147378367732, 7576.3181313682035, 7736.613169341623, 7748.34139098183, 7766.223377662189, 7769.883451748228, 825.7027470110755, 955.498363359228, 971.5967873332629, 973.0561355485167, 987.7283746969641, 21968.01143948526, 29270.0, 29276.560851587245, 29345.706542934724, 29880.55179172314, 1004.4324956399611, 1036.2487396300228, 1186.3178672263482, 1198.2930071257824, 1202.9534305154398, 13042.608721738363, 15068.623284417758, 15234.0, 15448.459303924308, 15743.68512629741, 655141.0, 664151.0, 664194.0, 664766.0, 665974.0, 57678.4232157673, 57722.4227757717, 58157.0, 58474.7076264616, 58900.1164982517, 1319.8218240537406, 1385.7436374270792, 1416.3060100550656, 1421.2396367943309, 1443.8483959184343, 29659.96190133335, 29900.401991959603, 30076.0, 30565.0, 30817.383652327277, 50972.490275096774, 51057.0, 51583.0, 51701.48298516967, 51764.70588235324, 321560.0, 428084.0, 431431.0, 432976.0, 434068.0, 40166.995825104605, 41422.58577414308, 42732.0, 42761.358579621956, 42849.92875178145, 35397.0, 39399.0, 40356.1928761429, 41061.58938410578, 41282.587174127875, 33520.49719254165, 34826.9551913443, 35025.64974350326, 35140.29719405649, 35289.0, 33922.66077339195, 34136.82931585326, 34610.75030123135, 34835.303293934485, 35016.0, 34406.483902740976, 34679.13302167466, 34713.479297810045, 34863.9540813776, 34868.82565587156, 32252.516212256367, 32394.190145246557, 32441.51337729983, 32443.837780810944, 33202.667973319956, 21654.67517987263, 22668.773312266665, 23928.521429571658, 24252.0, 25003.87498062498], "unit": "score", "name": "ext.html", "value": 19125.48016574054}, {"lowerIsBetter": false, "replicates": [361.21976530693723, 366.97981611011386, 369.58606360875814, 371.6190904323067, 375.7933136774774, 15213.315400806963, 18070.72893906591, 18426.631467370677, 18739.625207495843, 19482.0, 9259.490728009956, 11904.7619047619, 14908.850911490908, 19073.237070517163, 19157.904210478962, 3936.1734035852364, 4050.473438452997, 5297.046531624306, 5336.17289320156, 5354.759035843377, 4029.375446805735, 5717.742701578418, 5875.2949646042325, 5882.705864706769, 5964.821055368346, 5863.296404431453, 5905.173275741399, 6524.086627872078, 6550.901736473957, 6557.868842623145, 5563.805266815682, 6265.154204182422, 6492.188476440445, 6531.412172904437, 6542.836429089263, 4889.413270407574, 5451.400345961981, 5722.141678748179, 5752.741126649311, 5819.098039803837, 23863.880680596485, 23961.88019059911, 24066.03735850564, 24318.756812431828, 24355.391115222083, 2065.617860695761, 2219.4895174109884, 2242.4169715873827, 2373.8931748071204, 2824.6751623563346, 8561.529115898624, 8981.955090224572, 9908.009199080107, 10008.449535275557, 10100.78790545132, 1728.7234042553257, 1772.5745821002865, 1794.4168145352683, 1847.2313850763235, 1871.2140900821687, 96912.51543742306, 99140.0, 100036.99926001512, 100156.49921750344, 102013.46979795383, 11063.446827658585, 11339.829902551468, 11438.542458301576, 11441.370724610226, 11494.54021839117, 12905.96752259817, 13544.322783860966, 13555.525556605471, 13586.524471643444, 13621.863781362059, 8295.502269863828, 8461.196186362286, 8537.871931921027, 8552.401331906707, 8584.91415085841, 8436.02985656645, 8525.14748525155, 8622.741317760478, 8651.04838467768, 8686.261667758312, 3583.6595523425235, 3983.701222408273, 4271.231178387858, 4415.072834704748, 4499.865004049884, 1876.3807943378652, 1931.72506145943, 1957.9412617621495, 1973.7631484221986, 1977.8022197780394, 850.9914900851036, 857.6397912876607, 971.9805603887883, 1016.703702778948, 1082.4912291223113, 17784.91107544454, 18586.975985356417, 18653.533661658297, 18691.813081869008, 18791.718124228148, 858.3905427146796, 925.8009527951523, 977.8127036073697, 1032.912202462784, 1036.43514284715, 9730.36752611078, 10374.533146008447, 10544.05103540685, 10570.41862697559, 10583.0, 277232.0, 541536.0, 583791.0, 588268.0, 597686.0, 113608.0, 115602.0, 115913.0, 118328.0, 120448.0, 1136.0968030415838, 1177.1995043370591, 1182.751622159339, 1186.6736647422028, 1192.546832203757, 17522.649547009245, 17562.560935976704, 17634.1182940855, 17654.646907062044, 17913.552161195552, 50400.0, 51444.48555514547, 51614.48385516247, 52173.7391313041, 52473.737631313124, 65653.0, 68026.319736802, 68186.0, 68571.0, 68619.0, 7556.508826926232, 7662.425318101276, 7704.152543220129, 7731.845363092594, 7760.650770715444, 10287.691369258935, 11290.266132701676, 11701.888320609529, 11755.647330580096, 11992.0, 8012.799680008046, 8593.742187734379, 9564.713058608253, 9650.565724542554, 9826.722526071564, 8858.867116993122, 9967.700968970943, 9967.950160249153, 10049.69850904474, 10458.320209186379, 10266.794664106825, 10318.380897145895, 10342.741431463972, 10491.213159012952, 10516.57933682644, 7516.022917020752, 7528.661210245662, 7609.429292803173, 7617.885731713918, 7718.807029824075, 10025.097741203326, 10346.586136554453, 10380.06579407857, 10576.41829699374, 10588.311759735592], "unit": "score", "name": "jquery.html", "value": 9024.316296988256}, {"lowerIsBetter": false, "replicates": [1377.380178919486, 1541.6145963509123, 1546.4741987724178, 1843.3456123076307, 1865.4030710172751, 7858.174891636368, 7918.802029949255, 8639.956800215998, 8798.868016979743, 8811.0, 7130.893036604442, 8321.791955201108, 8387.748367548968, 8460.0, 8533.573321333939, 2461.310832966772, 2463.8768061596893, 2482.900683972648, 2491.4394261291245, 2492.2149522900227, 2422.563938491071, 2486.8259221854387, 2489.9128530501434, 2498.7386415294186, 2502.3744063984004, 2453.9386515337083, 2490.3649569359786, 2500.762427569378, 2507.1601013660356, 2511.7362676918933, 2248.325502349297, 2269.4326418395403, 2459.557279689655, 2496.0889275414524, 2499.450120973383, 2452.546278938384, 2479.4917042006527, 2486.3038349262238, 2489.2283392148493, 2513.3339664988794, 8687.565621718952, 8733.214010739064, 8754.299656027502, 8756.299496040301, 8784.868226976601, 5355.866103347408, 5485.6982865942355, 5507.118860982224, 5514.0, 5514.80698175566, 3615.7649752765988, 3702.9629703702885, 3740.989932718151, 3747.9437808432895, 3760.905977350561, 1049.2340591368343, 1066.3228849680509, 1066.5040756048475, 1102.1403305421784, 1106.2311693373108, 11595.94202028993, 11856.644300670994, 11919.642410727605, 11974.88025119755, 11987.760244795143, 4884.755762211875, 4904.852854414374, 4914.238293064581, 4959.801607935642, 4976.2038073908, 10084.69745907624, 10116.74708132288, 10142.036506531867, 10165.237607179492, 10165.796684066278, 5416.91874621881, 5457.426970168154, 5483.314585676791, 5487.533559647395, 5500.917486237709, 4436.112777444524, 4567.132244873464, 4874.46380898101, 4917.9016419672125, 4937.925931111036, 3348.5646865907765, 3946.605339466088, 4009.178118485762, 4017.216642754693, 4024.436578878901, 1310.8033794930836, 1322.24631959782, 1326.562234462625, 1336.993315033438, 1346.9259190744604, 1053.8735351757684, 1079.7246702090918, 1120.3054106453887, 1295.184034058537, 1298.441670081855, 7835.059792824897, 7913.208679132041, 8071.394645401619, 8072.394570407126, 8077.838443231102, 493.0828658694825, 502.0285747079413, 517.7540668182584, 520.9296744939461, 523.7800123947951, 6143.109249158847, 6177.660228687376, 6202.534809889276, 6231.9688401557705, 6280.183576135073, 10285.640002599874, 10563.524641391155, 10569.101626361691, 10591.417472039111, 10678.412687302272, 10451.84322235167, 10487.161027117812, 10505.842412363821, 10517.52671129801, 10606.681799546026, 6787.830304242335, 8075.3539716822515, 8166.510009399455, 8183.631736571869, 8242.752717418487, 7601.923980760122, 7671.38628909697, 7679.347255483346, 7699.615019249127, 7741.0, 8031.959840200761, 8322.20939010793, 9306.813863722824, 9466.81664791901, 9467.053294670477, 9553.90446095558, 9673.0, 9755.463449510346, 9875.20998320147, 9979.650712225037, 6774.288699686462, 6951.409130223988, 7303.0, 7480.513766605153, 7529.284717951786, 8122.39082068859, 8147.9185208147155, 8166.4283500154415, 8189.426740128134, 8193.46742461738, 7514.1358743742985, 7592.126905405949, 7598.810029749079, 7788.221177882167, 7798.025246844145, 7470.0662417197855, 7472.36484898768, 7500.662470188964, 7524.623768811428, 7619.352355049661, 7585.393168546613, 7623.695052198072, 7646.0, 7652.005239318853, 7656.693732250647, 6814.965925170342, 6887.414569761627, 6914.4468442525485, 6932.168139823253, 6947.756828510978, 6990.510664253454, 6991.2309645937885, 7053.1536215652395, 7067.0, 7080.964595176991], "unit": "score", "name": "mootools.html", "value": 4801.727689735862}, {"lowerIsBetter": false, "replicates": [267.64002416749463, 311.5513660329126, 337.82264311236605, 339.77405025657924, 340.9045467269166, 5456.836294911149, 6537.803865884025, 6584.14406127204, 6707.966460167704, 6757.729690812368, 5541.390447050821, 6255.843603909893, 6305.905411418832, 6548.803535893919, 6564.146660934072, 4907.705537667752, 4922.950770492303, 4928.507149285061, 4932.654714170009, 4937.481564435737, 4901.411830580335, 4913.26301054841, 4918.434380046287, 4919.0, 4934.975325123387, 4680.3681502997, 4804.1352556539805, 4832.565069143777, 4833.3958255218095, 4858.5627293543575, 4807.927881081769, 4822.107910036654, 4848.224284114524, 4859.028194361124, 4873.074115918, 3925.391564307537, 4010.1578668479656, 4100.958990410088, 4105.5894410559, 4139.523954745213, 6237.1891654084675, 6332.746690132389, 6347.047942808569, 6403.455706264973, 6434.646094464802, 5682.40334764852, 5689.459501347365, 5698.40166782486, 5724.542036637059, 5729.1119876419225, 6837.487188460886, 7075.0448689426785, 7091.964540177266, 7099.680514376865, 7112.0754301940415, 4229.625371754161, 4270.636995855356, 4629.120467111272, 4637.536246375369, 4644.558766917137, 7418.443616728767, 7456.067991501062, 7479.551226926347, 7516.173220945691, 7519.661615227274, 4652.720836749738, 4666.78999445019, 4667.579917807414, 4668.85993420198, 4693.319468677023, 3744.307303148926, 4593.173228818778, 4735.100330937111, 4761.738104404221, 4774.140654682121, 5674.148877668383, 5682.744276507485, 5699.74351154199, 5709.8287051388525, 5745.9712701437065, 5820.447057529528, 7127.786166415016, 7142.107236595426, 7161.856762864713, 7163.89254161188, 1629.2342598978462, 1647.5633957001405, 1668.8414600612923, 1672.2140593920838, 1672.882898197139, 1059.814532456817, 1065.8861489743238, 1071.9410432426291, 1073.350622873166, 1080.9621663241749, 5574.9442505574425, 6839.247682754893, 6848.828779280558, 6855.691493882788, 6873.312668733087, 7409.296116868889, 7419.2209817969415, 7433.256674332523, 7433.628318584049, 7437.293457121565, 6645.169353830771, 6854.280300568468, 6859.348361905611, 6865.519413641097, 6919.515633905679, 3140.5760222370145, 3523.841427135785, 3904.1801221743754, 3927.489426374553, 3939.5863434339553, 7799.220077992269, 7813.492123011986, 7934.563599001995, 7951.125376208613, 7956.801079973047, 7660.502067365604, 7691.038620172479, 7694.307512323918, 7704.768856934301, 7711.807204819812, 7704.075510938723, 7893.868655462993, 7915.0, 7920.366370690331, 7923.801904952422, 6513.804585862432, 6705.362990515893, 7415.962920185365, 7428.1086269647985, 7480.625968701652, 6570.310117437792, 6619.602823830585, 7301.269873012656, 7301.452391070798, 7319.5242309249725, 7620.161782203842, 7917.881231781643, 7922.881156782538, 7961.920380796118, 7962.203779622223, 4722.386089808303, 4742.454617719007, 4748.596369308648, 4759.7858096386435, 4763.69036012658, 7108.9289107110335, 7393.408527317694, 7400.296971787671, 7408.555486670817, 7424.220456851953, 5862.768818548153, 7117.181524124792, 7144.106986626672, 7157.498975071695, 7158.0, 7109.111361079865, 7143.249958754256, 7150.606716630636, 7160.856782864418, 7165.104361954755, 5807.680577568274, 6451.8064458064455, 6649.63427011519, 6833.58998460094, 7056.823579410556, 5463.863403414787, 7163.6060016699585, 7174.497785155198, 7175.425965922818, 7182.856342873218, 6998.16022077354, 7003.0, 7022.754203602849, 7031.191412987572, 7055.541389809646], "unit": "score", "name": "prototype.html", "value": 5162.991361149852}, {"lowerIsBetter": false, "replicates": [715.549204001479, 716.2837162837163, 723.7901008707476, 732.1799584465398, 742.8528923160845, 14779.482718104868, 15016.174110423923, 15117.470888518905, 15125.016873903189, 15166.317515711791, 13815.309234538283, 13871.930640346809, 14017.50938717145, 14020.509282175126, 14147.009709320351, 693.3690341788973, 703.8416356319839, 832.388194676912, 836.9832603347929, 840.4369072721261, 682.3756263019332, 773.234497847133, 835.5822088955522, 838.2958315015386, 856.5588721808274, 883.4964070479829, 888.1251966812684, 895.3956079646246, 898.9775255618597, 900.9909900900973, 884.5444596033049, 888.3515034025198, 892.4065496444856, 894.1416240409214, 899.0290486274807, 644.9000404937242, 656.1371796088176, 661.318841593155, 661.751843058853, 664.5447868210291, 14597.197154156516, 14676.04605700626, 14698.11811291326, 14811.481598144013, 14811.703765924622, 12635.74728505434, 12712.936435317857, 12725.74548509034, 12760.553380631633, 13096.934515327363, 10385.169186465064, 10410.854805971338, 10443.68668939933, 10491.527881245362, 10685.35887846724, 3708.332500149972, 4045.5638248421683, 4092.5062352241216, 4187.267228235077, 4207.284761590537, 78704.60647696782, 80251.59874200591, 80316.19683803145, 80750.0, 81080.59459702723, 9311.48786816718, 9371.718848434557, 9483.90516094844, 9564.091411315914, 9579.377340472847, 20237.19051237934, 20460.488487787923, 20497.692534611993, 20503.794962050488, 20565.58868822615, 7103.289671032855, 7187.56874587516, 7261.0, 7336.339729424378, 7356.632168391559, 3898.6101389860787, 3976.5228172619472, 3977.284088864032, 3987.4018897165656, 4026.959730402717, 3366.983165084159, 3367.865285388606, 3399.2351720862607, 3405.0, 3405.7058317839064, 543.8450041738085, 650.8633187030777, 651.1925212736173, 670.410039165541, 672.3108813466237, 488.42609933328197, 535.526059437393, 573.6758731316876, 584.9766009359578, 600.9819705408845, 8623.764305088625, 8631.741047768577, 8644.135586441305, 8726.0, 9040.231580315616, 519.9974000129976, 537.9946200538022, 593.9881202375929, 604.283923550594, 615.1572345886165, 4019.376996565537, 4037.818298176589, 4114.259433302034, 4187.120704651997, 4263.509696384894, 93359.0, 94726.0, 95957.0404295962, 96331.0, 96941.0, 57110.714446427504, 57922.42077579255, 70507.6474617634, 70825.58348833097, 80991.59504202442, 44168.3374749379, 49123.0, 62936.741265175355, 66767.0, 68796.31203687999, 8968.327375446997, 8968.641254350014, 9005.504697241715, 9143.908560914571, 9166.22087122602, 36459.27081458409, 47769.0, 48732.51267487422, 48757.5124248753, 49422.752886235336, 51086.489135108175, 66031.33968660443, 67036.0, 68215.65892170508, 68804.0, 10757.230097929074, 10942.890571094187, 11468.483918223534, 11550.82673759911, 11807.232529885874, 11965.76068478608, 12345.581560563829, 12415.255084694947, 12421.130520863453, 12424.875751242373, 11224.10207183407, 11484.655460336204, 11831.940840296087, 11946.223495472766, 12449.502019919464, 11312.886871131182, 11811.232269902428, 11935.52257909674, 12006.519739210335, 12391.814122788346, 10903.473513707928, 11450.370229637118, 11592.6522204334, 11651.12616553745, 12123.81814272769, 9334.299927505328, 9412.67055653049, 9648.372855764354, 9732.951335243279, 9746.0, 8369.707060252862, 9299.628014879328, 9946.204303655546, 9959.502024898582, 10061.798764024532], "unit": "score", "name": "yui.html", "value": 6798.92929220749}], "name": "dromaeo_css", "value": 7377.980062072584}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 111.0, 128.0, 155.0, 116.0, 124.0, 111.0, 114.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 120.3}, {"lowerIsBetter": true, "replicates": [158.0, 127.0, 153.0, 155.0, 122.0, 143.0, 140.0, 125.0, 152.0, 104.0], "unit": "score", "name": "audio-beat-detection", "value": 137.9}, {"lowerIsBetter": true, "replicates": [195.0, 202.0, 195.0, 201.0, 203.0, 228.0, 254.0, 204.0, 200.0, 197.0], "unit": "score", "name": "audio-dft", "value": 207.9}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 68.0, 79.0, 123.0, 77.0, 82.0, 82.0, 88.0, 63.0], "unit": "score", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [82.0, 87.0, 116.0, 79.0, 83.0, 83.0, 119.0, 97.0, 81.0, 96.0], "unit": "score", "name": "audio-oscillator", "value": 92.3}, {"lowerIsBetter": true, "replicates": [77.0, 139.0, 129.0, 95.0, 89.0, 95.0, 89.0, 96.0, 89.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 99.2}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 98.0, 98.0, 98.0, 97.0, 98.0, 149.0, 99.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 102.9}, {"lowerIsBetter": true, "replicates": [124.0, 96.0, 91.0, 95.0, 91.0, 92.0, 98.0, 91.0, 95.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 55.0, 57.0, 55.0, 57.0, 66.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 72.0, 66.0, 69.0, 72.0, 64.0, 65.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [88.0, 79.0, 104.0, 108.0, 111.0, 108.0, 87.0, 83.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.4}, {"lowerIsBetter": true, "replicates": [128.0, 133.0, 131.0, 133.0, 133.0, 147.0, 132.0, 127.0, 128.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.9}, {"lowerIsBetter": true, "replicates": [141.0, 145.0, 144.0, 136.0, 137.0, 142.0, 145.0, 179.0, 177.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 66.0, 66.0, 70.0, 68.0, 67.0, 83.0, 55.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1501.8000000000002}]} 03:27:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1501.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7377.98"}}} 03:27:57 INFO - Return code: 0 03:27:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:27:57 INFO - # TBPL SUCCESS # 03:27:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:27:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:27:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:27:58 INFO - 2016-01-29 03:27:58.011 screenresolution[2341:36469] starting screenresolution argv=screenresolution get 03:27:58 INFO - 2016-01-29 03:27:58.013 screenresolution[2341:36469] Display 0: 1600x1200x32@60 03:27:58 INFO - 2016-01-29 03:27:58.019 screenresolution[2342:36472] starting screenresolution argv=screenresolution list 03:27:58 INFO - Available Modes on Display 0 03:27:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:27:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:27:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:27:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:27:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:27:58 INFO - Intel Iris: 03:27:58 INFO - Chipset Model: Intel Iris 03:27:58 INFO - Type: GPU 03:27:58 INFO - Bus: Built-In 03:27:58 INFO - VRAM (Dynamic, Max): 1536 MB 03:27:58 INFO - Vendor: Intel (0x8086) 03:27:58 INFO - Device ID: 0x0a2e 03:27:58 INFO - Revision ID: 0x0009 03:27:58 INFO - Displays: 03:27:58 INFO - Display: 03:27:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:27:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:27:58 INFO - Display Serial Number: 1600x1200 60 03:27:58 INFO - Main Display: Yes 03:27:58 INFO - Mirror: Off 03:27:58 INFO - Online: Yes 03:27:58 INFO - Rotation: Supported 03:27:58 INFO - Return code: 0 03:27:58 INFO - Running post-action listener: _resource_record_post_action 03:27:58 INFO - Running post-run listener: _resource_record_post_run 03:27:59 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 2306048; Write bytes: 710630912; Read time: 32; Write time: 1926 03:27:59 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 384389632; Write bytes: 378541568; Read time: 29495; Write time: 673 03:27:59 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 2306048; Write bytes: 304904192; Read time: 32; Write time: 1197 03:27:59 INFO - Running post-run listener: _upload_blobber_files 03:27:59 INFO - Blob upload gear active. 03:27:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:27:59 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 03:27:59 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'] 03:27:59 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 03:27:59 INFO - (blobuploader) - INFO - Open directory for files ... 03:27:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:27:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:28:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:00 INFO - (blobuploader) - INFO - Done attempting. 03:28:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:28:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:28:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:01 INFO - (blobuploader) - INFO - Done attempting. 03:28:01 INFO - (blobuploader) - INFO - Iteration through files over. 03:28:01 INFO - Return code: 0 03:28:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:28:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:28:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dd59c7176c883958039a779daad6add502de14cb0a580cf75692409d96b5658f9b2f60d52d4028969cd01a257057e8da52d23191422d67c4339ef57898e5e14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cc154b5506b0767e92a36dc17f8d0cab36e4c14f6b8a9038e0d60c3a3098cb358cbea21da57b3da4b497427eebfdc3e1569d5d83247efe52dd023ab06b666c3"} 03:28:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:28:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:28:01 INFO - Contents: 03:28:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dd59c7176c883958039a779daad6add502de14cb0a580cf75692409d96b5658f9b2f60d52d4028969cd01a257057e8da52d23191422d67c4339ef57898e5e14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cc154b5506b0767e92a36dc17f8d0cab36e4c14f6b8a9038e0d60c3a3098cb358cbea21da57b3da4b497427eebfdc3e1569d5d83247efe52dd023ab06b666c3"} 03:28:01 INFO - Running post-run listener: copy_logs_to_upload_dir 03:28:01 INFO - Copying logs to upload dir... 03:28:01 INFO - mkdir: /builds/slave/test/build/upload/logs 03:28:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.599521 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-01-29 03:28:01.953909) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-29 03:28:01.957237) ========= 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.2rap4uRDWb/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.IwRL97s1tH/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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/7dd59c7176c883958039a779daad6add502de14cb0a580cf75692409d96b5658f9b2f60d52d4028969cd01a257057e8da52d23191422d67c4339ef57898e5e14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cc154b5506b0767e92a36dc17f8d0cab36e4c14f6b8a9038e0d60c3a3098cb358cbea21da57b3da4b497427eebfdc3e1569d5d83247efe52dd023ab06b666c3"} build_url:https://queue.taskcluster.net/v1/task/K5kKNuyzTSm264mZM9ElPA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/K5kKNuyzTSm264mZM9ElPA/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/7dd59c7176c883958039a779daad6add502de14cb0a580cf75692409d96b5658f9b2f60d52d4028969cd01a257057e8da52d23191422d67c4339ef57898e5e14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cc154b5506b0767e92a36dc17f8d0cab36e4c14f6b8a9038e0d60c3a3098cb358cbea21da57b3da4b497427eebfdc3e1569d5d83247efe52dd023ab06b666c3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-29 03:28:01.984300) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 03:28:01.984632) ========= 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.2rap4uRDWb/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.IwRL97s1tH/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.005180 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 03:28:02.034026) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 03:28:02.034407) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 03:28:02.035257) ========= ========= Total master_lag: 0.53 =========