builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0086 starttime: 1459320966.99 results: success (0) buildid: 20160329214942 builduid: b4509b01942d4d1fbc608e2f47ab5244 revision: e1c798332d3be8aed7b934d2e6b3982d5de7d902 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:06.994576) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:06.995008) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:06.995395) ========= 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.BlbliYY556/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.PzjUd0tVlW/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.004995 basedir: '/builds/slave/test' ========= master_lag: 0.13 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:07.135091) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:07.135439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:07.291019) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:07.291356) ========= 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.BlbliYY556/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.PzjUd0tVlW/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005674 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:07.348960) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:07.349435) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:07.350152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:07.350754) ========= 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.BlbliYY556/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.PzjUd0tVlW/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-29 23:56:07-- 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% 150M=0s 2016-03-29 23:56:07 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134357 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:07.507303) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:07.507623) ========= 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.BlbliYY556/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.PzjUd0tVlW/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.026347 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:07.614261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 23:56:07.614608) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e1c798332d3be8aed7b934d2e6b3982d5de7d902 --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 e1c798332d3be8aed7b934d2e6b3982d5de7d902 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BlbliYY556/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.PzjUd0tVlW/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-29 23:56:07,702 truncating revision to first 12 chars 2016-03-29 23:56:07,702 Setting DEBUG logging. 2016-03-29 23:56:07,702 attempt 1/10 2016-03-29 23:56:07,702 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e1c798332d3b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-29 23:56:08,700 unpacking tar archive at: fx-team-e1c798332d3b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.248704 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 23:56:08.886442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:08.887342) ========= echo e1c798332d3be8aed7b934d2e6b3982d5de7d902 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e1c798332d3be8aed7b934d2e6b3982d5de7d902'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BlbliYY556/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.PzjUd0tVlW/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 e1c798332d3be8aed7b934d2e6b3982d5de7d902 program finished with exit code 0 elapsedTime=0.005377 script_repo_revision: 'e1c798332d3be8aed7b934d2e6b3982d5de7d902' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:08.938525) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:08.938829) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 23:56:08.956639) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 7 secs) (at 2016-03-29 23:56:08.957127) ========= /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.BlbliYY556/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.PzjUd0tVlW/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 23:56:09 INFO - MultiFileLogger online at 20160329 23:56:09 in /builds/slave/test 23:56:09 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 23:56:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:56:09 INFO - {'append_to_log': False, 23:56:09 INFO - 'base_work_dir': '/builds/slave/test', 23:56:09 INFO - 'blob_upload_branch': 'Fx-Team', 23:56:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:56:09 INFO - 'branch': 'Fx-Team', 23:56:09 INFO - 'buildbot_json_path': 'buildprops.json', 23:56:09 INFO - 'config_files': ('talos/mac_config.py',), 23:56:09 INFO - 'default_actions': ('clobber', 23:56:09 INFO - 'read-buildbot-config', 23:56:09 INFO - 'download-and-extract', 23:56:09 INFO - 'populate-webroot', 23:56:09 INFO - 'create-virtualenv', 23:56:09 INFO - 'install', 23:56:09 INFO - 'run-tests'), 23:56:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:56:09 INFO - 'download_minidump_stackwalk': True, 23:56:09 INFO - 'download_symbols': 'ondemand', 23:56:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:56:09 INFO - 'tooltool.py': '/tools/tooltool.py', 23:56:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:56:09 INFO - '/tools/misc-python/virtualenv.py')}, 23:56:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:56:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:56:09 INFO - 'installer_path': 'installer.exe', 23:56:09 INFO - 'log_level': 'info', 23:56:09 INFO - 'log_name': 'talos', 23:56:09 INFO - 'log_to_console': True, 23:56:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:56:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:56:09 INFO - 'opt_config_files': (), 23:56:09 INFO - 'pip_index': False, 23:56:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:56:09 INFO - 'cmd': ('bash', 23:56:09 INFO - '-c', 23:56:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:56:09 INFO - 'enabled': True, 23:56:09 INFO - 'halt_on_failure': False, 23:56:09 INFO - 'name': 'check_screen_resolution'},), 23:56:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:56:09 INFO - 'cmd': ('bash', 23:56:09 INFO - '-c', 23:56:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:56:09 INFO - 'enabled': True, 23:56:09 INFO - 'halt_on_failure': False, 23:56:09 INFO - 'name': 'check_screen_resolution'},), 23:56:09 INFO - 'run_cmd_checks_enabled': True, 23:56:09 INFO - 'sps_profile': False, 23:56:09 INFO - 'sps_profile_interval': 0, 23:56:09 INFO - 'suite': 'dromaeojs-e10s', 23:56:09 INFO - 'system_bits': '32', 23:56:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:56:09 INFO - 'title': 't-yosemite-r7-0086', 23:56:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:56:09 INFO - 'use_talos_json': True, 23:56:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:56:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:56:09 INFO - 'work_dir': 'build'} 23:56:09 INFO - ##### 23:56:09 INFO - ##### Running clobber step. 23:56:09 INFO - ##### 23:56:09 INFO - Running pre-action listener: _resource_record_pre_action 23:56:09 INFO - Running main action method: clobber 23:56:09 INFO - rmtree: /builds/slave/test/build 23:56:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:56:10 INFO - Running post-action listener: _resource_record_post_action 23:56:10 INFO - ##### 23:56:10 INFO - ##### Running read-buildbot-config step. 23:56:10 INFO - ##### 23:56:10 INFO - Running pre-action listener: _resource_record_pre_action 23:56:10 INFO - Running main action method: read_buildbot_config 23:56:10 INFO - Using buildbot properties: 23:56:10 INFO - { 23:56:10 INFO - "project": "", 23:56:10 INFO - "product": "firefox", 23:56:10 INFO - "script_repo_revision": "production", 23:56:10 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 23:56:10 INFO - "repository": "", 23:56:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 23:56:10 INFO - "buildid": "20160329214942", 23:56:10 INFO - "pgo_build": "False", 23:56:10 INFO - "basedir": "/builds/slave/test", 23:56:10 INFO - "buildnumber": 573, 23:56:10 INFO - "slavename": "t-yosemite-r7-0086", 23:56:10 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 23:56:10 INFO - "platform": "yosemite_r7", 23:56:10 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 23:56:10 INFO - "branch": "fx-team", 23:56:10 INFO - "repo_path": "integration/fx-team", 23:56:10 INFO - "revision": "e1c798332d3be8aed7b934d2e6b3982d5de7d902", 23:56:10 INFO - "stage_platform": "macosx64", 23:56:10 INFO - "builduid": "b4509b01942d4d1fbc608e2f47ab5244", 23:56:10 INFO - "slavebuilddir": "test" 23:56:10 INFO - } 23:56:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 23:56:10 INFO - Running post-action listener: _resource_record_post_action 23:56:10 INFO - ##### 23:56:10 INFO - ##### Running download-and-extract step. 23:56:10 INFO - ##### 23:56:10 INFO - Running pre-action listener: _resource_record_pre_action 23:56:10 INFO - Running main action method: download_and_extract 23:56:10 INFO - mkdir: /builds/slave/test/build/tests 23:56:10 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')]} 23:56:10 INFO - https://queue.taskcluster.net/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 23:56:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 23:56:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 23:56:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 23:56:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 23:56:41 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json: timed out 23:56:41 INFO - retry: attempt #1 caught exception: timed out 23:56:41 INFO - retry: Failed, sleeping 30 seconds before retrying 23:57:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #2 23:57:14 INFO - Downloaded 1199 bytes. 23:57:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 23:57:14 INFO - Using the following test package requirements: 23:57:14 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 23:57:14 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:57:14 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 23:57:14 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:57:14 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 23:57:14 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:57:14 INFO - u'jsshell-mac.zip'], 23:57:14 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:57:14 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 23:57:14 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 23:57:14 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:57:14 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 23:57:14 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:57:14 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 23:57:14 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:57:14 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 23:57:14 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:57:14 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 23:57:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:57:14 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')]} 23:57:14 INFO - https://queue.taskcluster.net/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:57:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:57:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:57:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:57:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:57:15 INFO - Downloaded 17944813 bytes. 23:57:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:57:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 23:57:19 INFO - Return code: 0 23:57:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 23:57:19 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')]} 23:57:19 INFO - https://queue.taskcluster.net/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:57:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:57:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:57:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:57:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:57:20 INFO - Downloaded 17944813 bytes. 23:57:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:57:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 23:57:24 INFO - Return code: 0 23:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:24 INFO - https://queue.taskcluster.net/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:57:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 23:57:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 23:57:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 23:57:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 23:57:25 INFO - Downloaded 10847531 bytes. 23:57:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:57:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 23:57:25 INFO - Return code: 0 23:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:25 INFO - https://queue.taskcluster.net/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 23:57:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 23:57:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 23:57:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 23:57:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 23:57:29 INFO - Downloaded 111406795 bytes. 23:57:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 23:57:29 INFO - mkdir: /builds/slave/test/properties 23:57:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:57:29 INFO - Writing to file /builds/slave/test/properties/build_url 23:57:29 INFO - Contents: 23:57:29 INFO - build_url:https://queue.taskcluster.net/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 23:57:30 INFO - Running post-action listener: _resource_record_post_action 23:57:30 INFO - Running post-action listener: set_extra_try_arguments 23:57:30 INFO - ##### 23:57:30 INFO - ##### Running populate-webroot step. 23:57:30 INFO - ##### 23:57:30 INFO - Running pre-action listener: _resource_record_pre_action 23:57:30 INFO - Running main action method: populate_webroot 23:57:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:57:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:57:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:57:30 INFO - '--tppagecycles', 23:57:30 INFO - '7'], 23:57:30 INFO - 'tests': ['tsvgm']}}, 23:57:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:57:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:57:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:57:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 23:57:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:57:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:57:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:57:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:30 INFO - 'talos_options': ['--e10s'], 23:57:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:57:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:30 INFO - 'tests': ['damp', 'tps']}, 23:57:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:30 INFO - 'talos_options': ['--e10s'], 23:57:30 INFO - 'tests': ['damp', 'tps']}, 23:57:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:57:30 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 23:57:30 INFO - 'tests': ['dromaeo_dom']}, 23:57:30 INFO - 'other': {'tests': ['a11yr', 23:57:30 INFO - 'ts_paint', 23:57:30 INFO - 'tpaint', 23:57:30 INFO - 'sessionrestore', 23:57:30 INFO - 'sessionrestore_no_auto_restore', 23:57:30 INFO - 'tabpaint']}, 23:57:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:57:30 INFO - 'tests': ['a11yr', 23:57:30 INFO - 'ts_paint', 23:57:30 INFO - 'tpaint', 23:57:30 INFO - 'sessionrestore', 23:57:30 INFO - 'sessionrestore_no_auto_restore', 23:57:30 INFO - 'tabpaint']}, 23:57:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:57:30 INFO - 'tests': ['a11yr', 23:57:30 INFO - 'ts_paint', 23:57:30 INFO - 'tpaint', 23:57:30 INFO - 'sessionrestore', 23:57:30 INFO - 'sessionrestore_no_auto_restore', 23:57:30 INFO - 'tabpaint']}, 23:57:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:57:30 INFO - 'tests': ['a11yr', 23:57:30 INFO - 'ts_paint', 23:57:30 INFO - 'tpaint', 23:57:30 INFO - 'sessionrestore', 23:57:30 INFO - 'sessionrestore_no_auto_restore', 23:57:30 INFO - 'tabpaint']}, 23:57:30 INFO - 'other_l64': {'tests': ['a11yr', 23:57:30 INFO - 'ts_paint', 23:57:30 INFO - 'tpaint', 23:57:30 INFO - 'sessionrestore', 23:57:30 INFO - 'sessionrestore_no_auto_restore', 23:57:30 INFO - 'tabpaint']}, 23:57:30 INFO - 'other_nol64': {'tests': ['a11yr', 23:57:30 INFO - 'ts_paint', 23:57:30 INFO - 'tpaint', 23:57:30 INFO - 'sessionrestore', 23:57:30 INFO - 'sessionrestore_no_auto_restore', 23:57:30 INFO - 'tabpaint']}, 23:57:30 INFO - 'svgr': {'tests': ['tsvgx', 23:57:30 INFO - 'tsvgr_opacity', 23:57:30 INFO - 'tart', 23:57:30 INFO - 'tscrollx', 23:57:30 INFO - 'cart']}, 23:57:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:57:30 INFO - 'tests': ['tsvgx', 23:57:30 INFO - 'tsvgr_opacity', 23:57:30 INFO - 'tart', 23:57:30 INFO - 'tscrollx', 23:57:30 INFO - 'cart']}, 23:57:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:30 INFO - 'tests': ['tp5o']}, 23:57:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:30 INFO - 'talos_options': ['--e10s'], 23:57:30 INFO - 'tests': ['tp5o']}, 23:57:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:30 INFO - 'talos_options': ['--xperf_path', 23:57:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:57:30 INFO - 'tests': ['tp5n']}, 23:57:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:30 INFO - 'talos_options': ['--e10s', 23:57:30 INFO - '--xperf_path', 23:57:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:57:30 INFO - 'tests': ['tp5n']}}, 23:57:30 INFO - 'talos.zip': {'path': '', 23:57:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:57:30 INFO - Running post-action listener: _resource_record_post_action 23:57:30 INFO - ##### 23:57:30 INFO - ##### Running create-virtualenv step. 23:57:30 INFO - ##### 23:57:30 INFO - Running pre-action listener: _resource_record_pre_action 23:57:30 INFO - Running main action method: create_virtualenv 23:57:30 INFO - Creating virtualenv /builds/slave/test/build/venv 23:57:30 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 23:57:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:57:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:57:30 INFO - Using real prefix '/tools/python27' 23:57:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:57:31 INFO - Installing distribute.............................................................................................................................................................................................done. 23:57:34 INFO - Installing pip.................done. 23:57:34 INFO - Return code: 0 23:57:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:57: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')]} 23:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57: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')]} 23:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:34 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 0x1087c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7614df200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865fe00>, '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 0x1084c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10865ab20>, '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.BlbliYY556/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.PzjUd0tVlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 23:57:34 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 23:57:34 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 23:57:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlbliYY556/Render', 23:57:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:57:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:57:34 INFO - 'HOME': '/Users/cltbld', 23:57:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:57:34 INFO - 'LOGNAME': 'cltbld', 23:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:34 INFO - 'MOZ_NO_REMOTE': '1', 23:57:34 INFO - 'NO_EM_RESTART': '1', 23:57:34 INFO - 'PAGER': '/bin/cat', 23:57:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:34 INFO - 'PWD': '/builds/slave/test', 23:57:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:57:34 INFO - 'SHELL': '/bin/bash', 23:57:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzjUd0tVlW/Listeners', 23:57:34 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 23:57:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:57:34 INFO - 'USER': 'cltbld', 23:57:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:57:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:34 INFO - 'XPC_FLAGS': '0x0', 23:57:34 INFO - 'XPC_SERVICE_NAME': '0', 23:57:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:35 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 23:57:35 INFO - Cleaning up... 23:57:35 INFO - Return code: 0 23:57:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:57:35 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')]} 23:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:35 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')]} 23:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:35 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 0x1087c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7614df200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865fe00>, '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 0x1084c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10865ab20>, '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.BlbliYY556/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.PzjUd0tVlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 23:57:35 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 23:57:35 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 23:57:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlbliYY556/Render', 23:57:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:57:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:57:35 INFO - 'HOME': '/Users/cltbld', 23:57:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:57:35 INFO - 'LOGNAME': 'cltbld', 23:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:35 INFO - 'MOZ_NO_REMOTE': '1', 23:57:35 INFO - 'NO_EM_RESTART': '1', 23:57:35 INFO - 'PAGER': '/bin/cat', 23:57:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:35 INFO - 'PWD': '/builds/slave/test', 23:57:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:57:35 INFO - 'SHELL': '/bin/bash', 23:57:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzjUd0tVlW/Listeners', 23:57:35 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 23:57:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:57:35 INFO - 'USER': 'cltbld', 23:57:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:57:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:35 INFO - 'XPC_FLAGS': '0x0', 23:57:35 INFO - 'XPC_SERVICE_NAME': '0', 23:57:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:35 INFO - Downloading/unpacking psutil>=0.7.1 23:57:35 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 23:57:35 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 23:57:35 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 23:57:35 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 23:57:35 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 23:57:35 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 23:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:57:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:57:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:57:38 INFO - Installing collected packages: psutil 23:57:38 INFO - Running setup.py install for psutil 23:57:38 INFO - building 'psutil._psutil_osx' extension 23:57:38 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 23:57:39 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 23:57:39 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 23:57:39 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 23:57:39 INFO - building 'psutil._psutil_posix' extension 23:57:39 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 23:57:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:57:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:57:39 INFO - ^ 23:57:39 INFO - 1 warning generated. 23:57:39 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 23:57:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:57:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:57:39 INFO - Successfully installed psutil 23:57:39 INFO - Cleaning up... 23:57:39 INFO - Return code: 0 23:57:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:57:39 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')]} 23:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:39 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')]} 23:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:39 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 0x1087c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7614df200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865fe00>, '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 0x1084c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10865ab20>, '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.BlbliYY556/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.PzjUd0tVlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 23:57:39 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 23:57:39 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 23:57:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlbliYY556/Render', 23:57:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:57:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:57:39 INFO - 'HOME': '/Users/cltbld', 23:57:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:57:39 INFO - 'LOGNAME': 'cltbld', 23:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:39 INFO - 'MOZ_NO_REMOTE': '1', 23:57:39 INFO - 'NO_EM_RESTART': '1', 23:57:39 INFO - 'PAGER': '/bin/cat', 23:57:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:39 INFO - 'PWD': '/builds/slave/test', 23:57:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:57:39 INFO - 'SHELL': '/bin/bash', 23:57:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzjUd0tVlW/Listeners', 23:57:39 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 23:57:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:57:39 INFO - 'USER': 'cltbld', 23:57:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:57:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:39 INFO - 'XPC_FLAGS': '0x0', 23:57:39 INFO - 'XPC_SERVICE_NAME': '0', 23:57:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:57:40 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 23:57:40 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 23:57:40 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 23:57:40 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 23:57:40 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 23:57:40 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 23:57:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:57:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:57:42 INFO - Installing collected packages: mozsystemmonitor 23:57:42 INFO - Running setup.py install for mozsystemmonitor 23:57:42 INFO - Successfully installed mozsystemmonitor 23:57:42 INFO - Cleaning up... 23:57:42 INFO - Return code: 0 23:57:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:57:42 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')]} 23:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:42 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')]} 23:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:42 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 0x1087c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7614df200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865fe00>, '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 0x1084c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10865ab20>, '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.BlbliYY556/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.PzjUd0tVlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 23:57:42 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 23:57:42 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 23:57:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlbliYY556/Render', 23:57:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:57:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:57:42 INFO - 'HOME': '/Users/cltbld', 23:57:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:57:42 INFO - 'LOGNAME': 'cltbld', 23:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:42 INFO - 'MOZ_NO_REMOTE': '1', 23:57:42 INFO - 'NO_EM_RESTART': '1', 23:57:42 INFO - 'PAGER': '/bin/cat', 23:57:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:42 INFO - 'PWD': '/builds/slave/test', 23:57:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:57:42 INFO - 'SHELL': '/bin/bash', 23:57:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzjUd0tVlW/Listeners', 23:57:42 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 23:57:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:57:42 INFO - 'USER': 'cltbld', 23:57:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:57:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:42 INFO - 'XPC_FLAGS': '0x0', 23:57:42 INFO - 'XPC_SERVICE_NAME': '0', 23:57:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:43 INFO - Downloading/unpacking blobuploader==1.2.4 23:57:43 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 23:57:43 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 23:57:43 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 23:57:43 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 23:57:43 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 23:57:43 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 23:57:45 INFO - Downloading blobuploader-1.2.4.tar.gz 23:57:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:57:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:57:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:57: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 23:57: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 23:57: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 23:57: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 23:57: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 23:57: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 23:57:46 INFO - Downloading docopt-0.6.1.tar.gz 23:57:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:57:46 INFO - Installing collected packages: blobuploader, requests, docopt 23:57:46 INFO - Running setup.py install for blobuploader 23:57:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:57:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:57:46 INFO - Running setup.py install for requests 23:57:47 INFO - Running setup.py install for docopt 23:57:47 INFO - Successfully installed blobuploader requests docopt 23:57:47 INFO - Cleaning up... 23:57:47 INFO - Return code: 0 23:57:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:57: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')]} 23:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57: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')]} 23:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:47 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 0x1087c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7614df200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865fe00>, '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 0x1084c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10865ab20>, '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.BlbliYY556/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.PzjUd0tVlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 23:57:47 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 23:57:47 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 23:57:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlbliYY556/Render', 23:57:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:57:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:57:47 INFO - 'HOME': '/Users/cltbld', 23:57:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:57:47 INFO - 'LOGNAME': 'cltbld', 23:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:47 INFO - 'MOZ_NO_REMOTE': '1', 23:57:47 INFO - 'NO_EM_RESTART': '1', 23:57:47 INFO - 'PAGER': '/bin/cat', 23:57:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:47 INFO - 'PWD': '/builds/slave/test', 23:57:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:57:47 INFO - 'SHELL': '/bin/bash', 23:57:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzjUd0tVlW/Listeners', 23:57:47 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 23:57:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:57:47 INFO - 'USER': 'cltbld', 23:57:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:57:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:47 INFO - 'XPC_FLAGS': '0x0', 23:57:47 INFO - 'XPC_SERVICE_NAME': '0', 23:57:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:57:47 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-IebIV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:57:47 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-0H8bd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:57:48 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-1ein8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:57:48 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-QozMyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:57:48 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-_tiTYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:57:48 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-hLvJVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:57:48 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-gMnrGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:57:48 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-vZ7x7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:57:48 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-kw66TU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:57:48 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-qrFAUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:57:48 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-zJkWqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:57:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-5dgyXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:57:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-0uTdd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:57:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Cs9fe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:57:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-iuoTuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:57:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-dHM1kB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:57:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-oXtnu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:57:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:57:49 INFO - Running setup.py install for manifestparser 23:57:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:57:49 INFO - Running setup.py install for mozcrash 23:57:49 INFO - Running setup.py install for mozdebug 23:57:50 INFO - Running setup.py install for mozdevice 23:57:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:57:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:57:50 INFO - Running setup.py install for mozfile 23:57:50 INFO - Running setup.py install for mozhttpd 23:57:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:57:50 INFO - Running setup.py install for mozinfo 23:57:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:57:50 INFO - Running setup.py install for mozInstall 23:57:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:57:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:57:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:57:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:57:50 INFO - Running setup.py install for mozleak 23:57:50 INFO - Running setup.py install for mozlog 23:57:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:57:51 INFO - Running setup.py install for moznetwork 23:57:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:57:51 INFO - Running setup.py install for mozprocess 23:57:51 INFO - Running setup.py install for mozprofile 23:57:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:57:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:57:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:57:51 INFO - Running setup.py install for mozrunner 23:57:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:57:51 INFO - Running setup.py install for mozscreenshot 23:57:51 INFO - Running setup.py install for moztest 23:57:52 INFO - Running setup.py install for mozversion 23:57:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:57:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:57:52 INFO - Cleaning up... 23:57:52 INFO - Return code: 0 23:57:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:52 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 0x1087c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7614df200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865fe00>, '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 0x1084c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10865ab20>, '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.BlbliYY556/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.PzjUd0tVlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 23:57:52 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 23:57:52 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 23:57:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlbliYY556/Render', 23:57:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:57:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:57:52 INFO - 'HOME': '/Users/cltbld', 23:57:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:57:52 INFO - 'LOGNAME': 'cltbld', 23:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:52 INFO - 'MOZ_NO_REMOTE': '1', 23:57:52 INFO - 'NO_EM_RESTART': '1', 23:57:52 INFO - 'PAGER': '/bin/cat', 23:57:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:52 INFO - 'PWD': '/builds/slave/test', 23:57:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:57:52 INFO - 'SHELL': '/bin/bash', 23:57:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzjUd0tVlW/Listeners', 23:57:52 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 23:57:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:57:52 INFO - 'USER': 'cltbld', 23:57:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:57:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:52 INFO - 'XPC_FLAGS': '0x0', 23:57:52 INFO - 'XPC_SERVICE_NAME': '0', 23:57:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:57:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-DeDh6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:57:52 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)) 23:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:57:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-IIB_XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:57:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-gkDUtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:57:52 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)) 23:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:57:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-2WHzkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:57:52 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)) 23:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:57:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-P_DDaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:57:52 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)) 23:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:57:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-B3c26h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:57:53 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)) 23:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:57:53 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-yCEZkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:57:53 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)) 23:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:57:53 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-lKqPjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:57:53 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)) 23:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:57:53 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-0azJrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:57:53 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)) 23:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:57:53 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-btzxoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:57:53 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)) 23:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:57:53 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-fnE9Kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:57:53 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)) 23:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:57:53 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-McEWq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:57:53 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)) 23:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:57:53 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-kTMQ9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:57:53 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)) 23:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:57:53 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Wx91aN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:57:53 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)) 23:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:57:53 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-_RRHr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:57:54 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)) 23:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:57:54 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-u8IdCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:57:54 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)) 23:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:57:54 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-WCfbEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:57:54 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)) 23:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:57:54 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)) 23:57:54 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)) 23:57:54 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)) 23:57:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:56 INFO - Downloading blessings-1.6.tar.gz 23:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:57:56 INFO - Installing collected packages: blessings 23:57:56 INFO - Running setup.py install for blessings 23:57:56 INFO - Successfully installed blessings 23:57:56 INFO - Cleaning up... 23:57:56 INFO - Return code: 0 23:57:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:57:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:57:57 INFO - Reading from file tmpfile_stdout 23:57:57 INFO - Current package versions: 23:57:57 INFO - blessings == 1.6 23:57:57 INFO - blobuploader == 1.2.4 23:57:57 INFO - docopt == 0.6.1 23:57:57 INFO - manifestparser == 1.1 23:57:57 INFO - mozInstall == 1.12 23:57:57 INFO - mozcrash == 0.17 23:57:57 INFO - mozdebug == 0.1 23:57:57 INFO - mozdevice == 0.48 23:57:57 INFO - mozfile == 1.2 23:57:57 INFO - mozhttpd == 0.7 23:57:57 INFO - mozinfo == 0.9 23:57:57 INFO - mozleak == 0.1 23:57:57 INFO - mozlog == 3.1 23:57:57 INFO - moznetwork == 0.27 23:57:57 INFO - mozprocess == 0.22 23:57:57 INFO - mozprofile == 0.28 23:57:57 INFO - mozrunner == 6.11 23:57:57 INFO - mozscreenshot == 0.1 23:57:57 INFO - mozsystemmonitor == 0.0 23:57:57 INFO - moztest == 0.7 23:57:57 INFO - mozversion == 1.4 23:57:57 INFO - psutil == 3.1.1 23:57:57 INFO - requests == 1.2.3 23:57:57 INFO - wsgiref == 0.1.2 23:57:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:57:57 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')]} 23:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:57 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')]} 23:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:57 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 0x1087c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7614df200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865fe00>, '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 0x1084c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10865ab20>, '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.BlbliYY556/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.PzjUd0tVlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 23:57:57 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 23:57:57 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 23:57:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlbliYY556/Render', 23:57:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:57:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:57:57 INFO - 'HOME': '/Users/cltbld', 23:57:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:57:57 INFO - 'LOGNAME': 'cltbld', 23:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:57 INFO - 'MOZ_NO_REMOTE': '1', 23:57:57 INFO - 'NO_EM_RESTART': '1', 23:57:57 INFO - 'PAGER': '/bin/cat', 23:57:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:57 INFO - 'PWD': '/builds/slave/test', 23:57:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:57:57 INFO - 'SHELL': '/bin/bash', 23:57:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzjUd0tVlW/Listeners', 23:57:57 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 23:57:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:57:57 INFO - 'USER': 'cltbld', 23:57:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:57:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:57 INFO - 'XPC_FLAGS': '0x0', 23:57:57 INFO - 'XPC_SERVICE_NAME': '0', 23:57:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:57 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)) 23:57:57 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)) 23:57:57 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)) 23:57:57 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)) 23:57:57 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)) 23:57:57 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)) 23:57:57 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)) 23:57:57 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)) 23:57:57 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)) 23:57:57 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)) 23:57:57 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)) 23:57:57 INFO - Cleaning up... 23:57:57 INFO - Return code: 0 23:57:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:57:57 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')]} 23:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:57 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')]} 23:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:57 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 0x1087c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7614df200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865fe00>, '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 0x1084c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10865ab20>, '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.BlbliYY556/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.PzjUd0tVlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 23:57:57 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 23:57:57 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 23:57:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlbliYY556/Render', 23:57:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:57:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:57:57 INFO - 'HOME': '/Users/cltbld', 23:57:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:57:57 INFO - 'LOGNAME': 'cltbld', 23:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:57 INFO - 'MOZ_NO_REMOTE': '1', 23:57:57 INFO - 'NO_EM_RESTART': '1', 23:57:57 INFO - 'PAGER': '/bin/cat', 23:57:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:57 INFO - 'PWD': '/builds/slave/test', 23:57:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:57:57 INFO - 'SHELL': '/bin/bash', 23:57:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzjUd0tVlW/Listeners', 23:57:57 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 23:57:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:57:57 INFO - 'USER': 'cltbld', 23:57:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:57:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:57 INFO - 'XPC_FLAGS': '0x0', 23:57:57 INFO - 'XPC_SERVICE_NAME': '0', 23:57:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:57 INFO - Downloading/unpacking jsonschema 23:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:58:00 INFO - Downloading/unpacking functools32 (from jsonschema) 23:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:00 INFO - Downloading functools32-3.2.3-2.tar.gz 23:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:58:00 INFO - warning: no files found matching '*.txt' 23:58:00 INFO - no previously-included directories found matching 'build' 23:58:00 INFO - no previously-included directories found matching 'dist' 23:58:00 INFO - no previously-included directories found matching '.git*' 23:58:00 INFO - Installing collected packages: jsonschema, functools32 23:58:00 INFO - Running setup.py install for functools32 23:58:00 INFO - warning: no files found matching '*.txt' 23:58:00 INFO - no previously-included directories found matching 'build' 23:58:00 INFO - no previously-included directories found matching 'dist' 23:58:00 INFO - no previously-included directories found matching '.git*' 23:58:00 INFO - Successfully installed jsonschema functools32 23:58:00 INFO - Cleaning up... 23:58:00 INFO - Return code: 0 23:58:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:58:00 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')]} 23:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:00 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')]} 23:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:00 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 0x1087c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7614df200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865fe00>, '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 0x1084c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10865ab20>, '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.BlbliYY556/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.PzjUd0tVlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 23:58:00 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 23:58:00 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 23:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlbliYY556/Render', 23:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:00 INFO - 'HOME': '/Users/cltbld', 23:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:00 INFO - 'LOGNAME': 'cltbld', 23:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:00 INFO - 'MOZ_NO_REMOTE': '1', 23:58:00 INFO - 'NO_EM_RESTART': '1', 23:58:00 INFO - 'PAGER': '/bin/cat', 23:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:00 INFO - 'PWD': '/builds/slave/test', 23:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:00 INFO - 'SHELL': '/bin/bash', 23:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzjUd0tVlW/Listeners', 23:58:00 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 23:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:00 INFO - 'USER': 'cltbld', 23:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:00 INFO - 'XPC_FLAGS': '0x0', 23:58:00 INFO - 'XPC_SERVICE_NAME': '0', 23:58:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:01 INFO - Downloading/unpacking flake8 23:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:58:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:58:03 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 23:58:03 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 23:58:03 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 23:58:03 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 23:58:03 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 23:58:03 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 23:58:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:58:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:58:03 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 23:58:03 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 23:58:03 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 23:58:03 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 23:58:03 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 23:58:03 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 23:58:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:58:04 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 23:58:04 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 23:58:04 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 23:58:04 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 23:58:04 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 23:58:04 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 23:58:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:58:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:58:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:58:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:58:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:58:04 INFO - no previously-included directories found matching 'docs/_build' 23:58:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:58:04 INFO - Running setup.py install for pep8 23:58:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:58:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:58:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:58:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:58:04 INFO - no previously-included directories found matching 'docs/_build' 23:58:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:58:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:58:05 INFO - Cleaning up... 23:58:05 INFO - Return code: 0 23:58:05 INFO - Running post-action listener: _resource_record_post_action 23:58:05 INFO - Running post-action listener: _start_resource_monitoring 23:58:05 INFO - Starting resource monitoring. 23:58:05 INFO - ##### 23:58:05 INFO - ##### Running install step. 23:58:05 INFO - ##### 23:58:05 INFO - Running pre-action listener: _resource_record_pre_action 23:58:05 INFO - Running main action method: install 23:58:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:58:05 INFO - Reading from file tmpfile_stdout 23:58:05 INFO - Detecting whether we're running mozinstall >=1.0... 23:58:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:58:05 INFO - Reading from file tmpfile_stdout 23:58:05 INFO - Output received: 23:58:05 INFO - Usage: mozinstall [options] installer 23:58:05 INFO - Options: 23:58:05 INFO - -h, --help show this help message and exit 23:58:05 INFO - -d DEST, --destination=DEST 23:58:05 INFO - Directory to install application into. [default: 23:58:05 INFO - "/builds/slave/test"] 23:58:05 INFO - --app=APP Application being installed. [default: firefox] 23:58:05 INFO - mkdir: /builds/slave/test/build/application 23:58:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 23:58:39 INFO - Reading from file tmpfile_stdout 23:58:39 INFO - Output received: 23:58:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:58:39 INFO - Running post-action listener: _resource_record_post_action 23:58:39 INFO - ##### 23:58:39 INFO - ##### Running run-tests step. 23:58:39 INFO - ##### 23:58:39 INFO - Running pre-action listener: _resource_record_pre_action 23:58:39 INFO - Running main action method: run_tests 23:58:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:58:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:58:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:58:39 INFO - 2016-03-29 23:58:39.523 screenresolution[1646:8451] starting screenresolution argv=screenresolution get 23:58:39 INFO - 2016-03-29 23:58:39.526 screenresolution[1646:8451] Display 0: 1600x1200x32@60 23:58:39 INFO - 2016-03-29 23:58:39.531 screenresolution[1647:8453] starting screenresolution argv=screenresolution list 23:58:39 INFO - Available Modes on Display 0 23:58:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:58:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:58:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:58:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:58:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:58:39 INFO - Intel Iris: 23:58:39 INFO - Chipset Model: Intel Iris 23:58:39 INFO - Type: GPU 23:58:39 INFO - Bus: Built-In 23:58:39 INFO - VRAM (Dynamic, Max): 1536 MB 23:58:39 INFO - Vendor: Intel (0x8086) 23:58:39 INFO - Device ID: 0x0a2e 23:58:39 INFO - Revision ID: 0x0009 23:58:39 INFO - Displays: 23:58:39 INFO - Display: 23:58:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:58:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:58:39 INFO - Display Serial Number: 1600x1200 60 23:58:39 INFO - Main Display: Yes 23:58:39 INFO - Mirror: Off 23:58:39 INFO - Online: Yes 23:58:39 INFO - Rotation: Supported 23:58:39 INFO - Return code: 0 23:58:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:58:39 INFO - Python 2.7.3 23:58:39 INFO - Return code: 0 23:58:39 INFO - grabbing minidump binary from tooltool 23:58:39 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')]} 23:58:39 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 0x10865fe00>, '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 0x1084c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10865ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:58:39 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 23:58:39 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 23:58:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:58:39 INFO - Return code: 0 23:58:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:58:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:58:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:58:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:58:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:58:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:58:41 INFO - Return code: 0 23:58:41 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/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 23:58:41 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/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --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 23:58:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BlbliYY556/Render', 23:58:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:41 INFO - 'HOME': '/Users/cltbld', 23:58:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:41 INFO - 'LOGNAME': 'cltbld', 23:58:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:58:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:41 INFO - 'MOZ_NO_REMOTE': '1', 23:58:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:58:41 INFO - 'NO_EM_RESTART': '1', 23:58:41 INFO - 'PAGER': '/bin/cat', 23:58:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:41 INFO - 'PWD': '/builds/slave/test', 23:58:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:58:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:41 INFO - 'SHELL': '/bin/bash', 23:58:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzjUd0tVlW/Listeners', 23:58:41 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 23:58:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:41 INFO - 'USER': 'cltbld', 23:58:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:41 INFO - 'XPC_FLAGS': '0x0', 23:58:41 INFO - 'XPC_SERVICE_NAME': '0', 23:58:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:58:41 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/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 23:58:41 INFO - mozversion application_buildid: 20160329214942 23:58:41 INFO - mozversion application_changeset: e1c798332d3be8aed7b934d2e6b3982d5de7d902 23:58:41 INFO - mozversion application_display_name: Nightly 23:58:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:58:41 INFO - mozversion application_name: Firefox 23:58:41 INFO - mozversion application_remotingname: firefox 23:58:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:58:41 INFO - mozversion application_vendor: Mozilla 23:58:41 INFO - mozversion application_version: 48.0a1 23:58:41 INFO - mozversion platform_buildid: 20160329214942 23:58:41 INFO - mozversion platform_changeset: e1c798332d3be8aed7b934d2e6b3982d5de7d902 23:58:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:58:41 INFO - mozversion platform_version: 48.0a1 23:58:41 INFO - using testdate: 1459321121 23:58:41 INFO - actual date: 1459321121 23:58:41 INFO - starting webserver on 'localhost:49276' 23:58:41 INFO - SUITE-START | Running 2 tests 23:58:41 INFO - TEST-START | dromaeo_css 23:58:41 INFO - operating with platform_type : mac_ 23:58:41 INFO - Initialising browser for dromaeo_css test... 23:58:41 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmp2pksvD/profile http://localhost:49276/getInfo.html) 23:58:43 INFO - PROCESS | 1665 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 23:58:44 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 23:58:44 INFO - PROCESS | 1665 | colorDepth:24 23:58:44 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 23:58:44 INFO - PROCESS | 1665 | __metrics 23:58:44 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 23:58:45 INFO - TEST-INFO | 1665: exit 0 23:58:45 INFO - Browser initialized. 23:58:45 INFO - Running cycle 1/1 for dromaeo_css test... 23:58:45 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmp2pksvD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:58:57 INFO - PROCESS | 1670 | RSS: Main: 254529536 23:58:57 INFO - PROCESS | 1670 | 23:59:46 INFO - PROCESS | 1670 | 1459321186897 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] 00:01:57 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 00:01:59 INFO - PROCESS | 1670 | RSS: Main: 268394496 00:01:59 INFO - PROCESS | 1670 | 00:05:01 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 00:05:02 INFO - PROCESS | 1670 | RSS: Main: 280686592 00:05:02 INFO - PROCESS | 1670 | 00:08:03 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 00:08:04 INFO - PROCESS | 1670 | RSS: Main: 282312704 00:08:04 INFO - PROCESS | 1670 | 00:11:06 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 00:11:06 INFO - PROCESS | 1670 | RSS: Main: 285945856 00:11:06 INFO - PROCESS | 1670 | 00:14:09 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 00:14:09 INFO - PROCESS | 1670 | RSS: Main: 285761536 00:14:09 INFO - PROCESS | 1670 | 00:17:11 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 00:17:12 INFO - PROCESS | 1670 | RSS: Main: 289832960 00:17:12 INFO - PROCESS | 1670 | 00:17:12 INFO - PROCESS | 1670 | __start_tp_report 00:17:12 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 00:17:12 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 00:17:12 INFO - PROCESS | 1670 | |i|pagename|runs| 00:17:12 INFO - PROCESS | 1670 | |0;dojo.html;2926.809757365771;3515.4375299952003;3535.575730912291;3557.270759494304;3572.964270357299;4755.976220118894;5367.275417818598;5591.329040515144;5798.942010579898;5825.796097136596;4644.837430689927;4715.693479923802;5440.319960004999;5599.832005039855;5804.941950580493;4320.416743739586;5164.45773193814;5184.274201611777;5206.505381988705;5355.7857685692525;5107.157319042353;5317.202419637047;5335.893282134355;5349.384820745606;5397.4062853086325;5166.1217593008905;5179.14544100223;5215.608829337796;5231.633785635007;5242.8165014224505;5235.136202526579;5236.895262094737;5240.925610249928;5253.343332083489;5256.789728410859;5186.7147306898105;5191.558717509016;5195.766190521435;5216.686998780047;5243.842684719426;4725.196716558194;5407.107827208506;5642.689652069134;5684.602077854552;5757.913631295534;5570.972145139248;5884.970575147139;6178.752849885999;6251.156093927352;6276.686165691697;6160.383961603804;6236.532260080467;6239.750409983641;6262.342454042306;6273.247210334744;4638.628909687217;5877.706114694291;5919.112133180014;5925.881482370329;5956.5532585055425;5262;6280.371962803774;6320.525960552977;6321.209848768904;6329.208848893888;6101.450869421685;6203.96898015507;6233.937660623426;6235.158253635792;6249.031400132987;6185.474234690012;6216;6231.096491008779;6233.501319894398;6235;6040.516758659297;6085.756569737249;6113.467391846696;6129.540284478682;6162.198914141133;6062.211912451441;6147.600405973598;6206.968965155145;6207.131001659771;6236.719347629368;4928.433230178575;4930.5069493050405;4939.481354457802;4945.530174633404;4979.128652485801;4418.690691651618;4422.226110430662;4442.2892337225885;4445.1998640245065;4468.106378724268;5835.328937172195;5893.823185304362;5909.852253693692;5954.315253745788;6019.458248757633;6168.845778855564;6192.938070619326;6214.005759078525;6227.532935029801;6258;5938.6436813791315;5948.702564871739;5956.583039187302;5958.553108516879;5990.820275391745;5328.706921119376;5411.134218525017;5424.077906755861;5457.645253058538;5476.7535460903555;6334.271558770801;6411.6153030818305;6414.550981431255;6414.807555773335;6416.294207637063;6207.875842483216;6215.34738852414;6221.502279817513;6225.097360882556;6263.592866463665;6175.660338681416;6328.493720502257;6339.366063393623;6415.454686351526;6415.486761059011;6211.09939058843;6213.37866213375;6259.718312676032;6263.3736626337;6281.183446151971;4784.760761961818;5105.336306280308;6215.96892015537;6227.906581401192;6264.59280146789;6031.5476339273855;6105.053716673922;6165.599236049642;6172.22847144107;6176.505879529716;6083.6349819011;6115.970584430425;6163.96918015407;6176.166217560572;6180;5951.375105613848;6032.819015429544;6058.818235452944;6101.84745381369;6109.877802443837;5617.382087970238;6116.914073580098;6120.9347721082095;6134.877302454015;6215.005599104122;6104.578931152009;6120.2947619997085;6121.178620693132;6126.214173165583;6141.385861413823 00:17:12 INFO - PROCESS | 1670 | |1;ext.html;522.2244966225155;536.9047143826594;556.0214023318958;586.9054213891093;594.8661551150991;38366.424503632436;39293.410598841;39297.21405571887;39354.8032259839;39364.40953385698;33547.4967875482;41162.76511704646;41565;41567;41757;9570.760730981729;9721.951390243039;9747.805043899118;9764.023597640251;9776.853347199798;9520.047995200493;9761.97499262578;9770.804583908317;9774.462404567746;9815.263855210887;9732.318737688365;9832.31173817833;9842.753931151707;9857.014298570122;9867.802643947116;9732.65935692251;9749.561269742808;9827.4103553787;9839.016098390175;9850.50747462631;8420.789480262982;9630.711078667651;9780.608775648965;9800.460974646392;9814.362066465728;39105.804470977746;39238.019049523704;39318.60681393178;39454.0136496587;39884;3123.9843800781077;3229.46713792224;3328.9334213315597;3411.710004649583;3428.0230134411822;27820.721792782017;27974.02090926828;28905.42189156205;29437;29587.852060739773;2630.921072367832;2722.469118521889;2724.1146627346193;2735.9726402736114;2885.365219651673;509676;512821;513071.9999999963;513987;515093;46246.768766155954;71401;71988.64005680043;72246.63876680583;72285;44914;45999;46256.768716156206;46302;46338.76830615825;15652.295646695926;16016.519504414886;16075.758863617055;16175.110368929587;16240.918795405947;12555.811662825065;12793.42429590652;12854.357282135856;12903.419346129447;12964.481420743254;14841.40634374613;14936.775948360782;15009.174495402858;15047.097174169585;15097.622559436102;6354.586951848115;6604.306547812506;6638.4357329626555;6685.827106190508;6695.497837662195;952.5808644196532;982.2633025230933;1086.5816660585574;1113.5156207049959;1130.8077626803463;29791.702082978893;29861.402771944875;30114.84942575273;30465.695343046285;30489.847550762548;1067.2529229539352;1089.5859573362072;1105.8230683090667;1118.4687273545;1144.9942750286195;15175.544733658007;15323;15361;15361.462348817739;15462.28312674025;521982;522456;523761;529659;530129;59554.40445595575;60627.393726062175;61795.691021544604;61807;61807.055435565046;1436.1454934314067;1475.4762059468949;1485.843986381436;1491.6047247479426;1498.1161114942236;26446;28058.85970570134;29452.705472944996;29603.963861264754;29606.259843503223;39779.40330895097;44538.10923781571;44799.65601031974;52999.47000529945;53262.46737532575;471432;474569;475057;475498;476369;34170.48744268888;37842.43236351402;41271.1745765077;44622;46372;34569;44714.77642611766;44833.327500086874;44865.77567112144;45169.87075323012;26635.600465992637;37186.44220336643;37524.812375937945;38101.4284785734;38148.66479673198;35459.82270088633;36437.724679636085;37019;38104.428433574074;38725.61274387333;37493.062673433385;37842.81078594589;37896.43155352617;38364.42453363258;38544;31626.36747265088;33568.99293021213;34211.31577368489;34529.30941381209;34623;24793.380165496008;24967.250982470556;25073;25414.237572872844;25575.48849022972 00:17:12 INFO - PROCESS | 1670 | |2;jquery.html;351.6307876729432;356.2660918507873;356.9839357228925;360.91879327151395;361.0036498165148;19849.007549622533;20164.59670806583;21769.802660853646;21843.344699659017;21848;19966.600667986633;20112.597748045067;20586.279480218196;20777.896110519465;20847.47881302968;4432.778361081949;5249.396319423258;5263.789448422059;5268.710220937847;5303.124984377573;3921.29416704993;5156.175011998081;5668.858278543049;5952;5964.314103878044;5925.5555833312455;5939.7921072762465;5946.256717910262;5947.7620895164355;5952.851178720523;5732.22614946981;5825.30096388434;5858.2677165354335;5886.411358864122;5890.145928840337;5574.052411090124;5601.383847776741;5618.353889302701;5630.071038278679;5635.80274690388;12862.807057894139;17382.001069876875;20275.695864562043;25362.619560706604;25427.49145017089;1911.4361263427322;2063.8658487198286;2088.0812442525394;2167.2522979572022;2203.294945617403;8199.344052475788;9543.188828949478;9970.551325190383;9994.600215991424;10098.89901100987;1728.5592173995676;1755.6488702259599;1780.8486278666328;1781.6169523552499;1823.8176182381787;80693;97810;98528;99823.50088249512;100185.99442016751;10939.28894621847;11027.393493357782;11151.944240278746;11302;11370;13417.127886687334;13565.525206617722;13591.252481113435;13601;13619;7880.724174653859;8543.102974187621;8670.393072484992;8686.218240358397;8731.912680873236;8555.486670799772;8782.121787821166;8792.241551689687;8796.34027447944;8866.955665221632;3581.94627080594;3663.9633603663624;4345.478542574911;4434.578715022068;4456.46522417312;1609.2597405193742;1713.1605513298643;1774.2636805725738;1827.2873579304082;1858.990705046466;863.7495126413395;866.4281574161149;884.8849649545647;955.6941778630771;988.7923536057365;18068.36760713369;19623.50941226452;20108.296209632885;20112.379771641245;20848.58302833965;920.2545937790411;925.7407925780792;948.6537413843897;960.8270511308032;1024.0987930621006;10764.977327153907;10873.401962892116;10965.177611679155;10980.780384392427;11031.062359699356;591784;602562;605044;621597;621937.8903105456;108797;113346.43326783313;113727.43136284266;115020;116232;1018.063381688848;1039.0856046678873;1045.383223897904;1047.994760026195;1067.6583493282076;17788.598539197043;17843.286268549113;18387.632247355246;18615.813841861407;19425.222991080198;51996.74001629968;53046;53337;53631.731841340545;54497;70796;70820;72030.63984680253;72586.27413725795;73152.63423682848;7626.466147369631;7816.296533312029;7892;7989.640466178919;8195.221453961864;11872.881271187523;12446.751064978831;12524.935380492396;12717.55488557896;12851;9014.684486042957;10977.121830253402;11164.665060048212;11418.714532136763;11426.771464570827;11065.446727663424;11077.279976801483;11110;11175.105991520497;11344.149188811038;9857.408555486694;11390.943045284721;11485.425728713364;11540.769184616092;11668.241564298294;7626.809329766578;7942.285194332538;7976.7208147714555;8038.437309388521;8088.393370497119;9710.854337184806;11035.227534072537;11061.281016733887;11095.88904110981;11392.316461012366 00:17:12 INFO - PROCESS | 1670 | |3;mootools.html;1642.9835701642983;1667.5580971042673;1851.7222416637503;2025.5543780368314;2025.9290924817635;8122;8834.381593288472;8869.201771840533;9018.549072546371;9019.503927283997;8917.554122293892;8941.821163576724;8956.596953137108;9036.5933532991;9076.36465447419;2498.275500104972;2514.660520829683;2520.987395063022;2525.848449093051;2544.580144276192;2460.778529932306;2529.949401011979;2537.0739680016845;2538.9111381101666;2538.9746102539016;2484.366486545928;2509.335026218054;2511.7613826686434;2536.340551456616;2547.7197508274076;2480.957997640995;2481.4416756229793;2491.6137998610243;2516.798656107507;2527.0397249045427;2494.550980823451;2522.646829443879;2525.3181640957023;2525.7726804587674;2540.174443305933;9100.681476148304;9194.954025229898;9258.444493330422;9259;9286.767830804216;5545.584081193927;5607.158926161068;5646.20953066571;5786.797462088806;5817.912731308991;2948.5871977923107;3114.8909788157307;3641.799701016443;3772.2078363543687;3808.428735689641;1071.2929466552039;1088.4775307852196;1090.0679918669582;1090.487470888681;1090.6400887707039;12246.571370002008;12482.75034499305;12547.372631368395;12560.057995650362;12586.874131258663;5013.473585273567;5015.247712843103;5031.723255220924;5114.948850511447;5114.948850511521;10570.788584228272;10581.418022008864;10602.204834637432;10645.627403040857;10656.25406221557;4566.315052742115;5560.332760068818;5666.914996275059;5672.829815105553;5681.829545113653;4067.491563554556;4361.9127617447475;4406.867793966187;4576.176288268143;4578.198815207392;3344.6320904700465;3421.8973430797114;3953.2686453006286;4012.779297138627;4082.9795851020554;1320.8442612713875;1325.2379881567945;1329.9800502992464;1342.6307765364602;1351.3716122003316;1330.966725831862;1361.2241022617013;1383.3152589468277;1402.4109873853006;1410.2102822419479;8345.791355216168;8389.832203355898;8526.957365213135;8535.445196062235;8543.572821358906;460.70745076876426;522.7020598259032;532.1113740054119;535.5742184962963;540.5972550449861;6253.093301471261;6297.6536290503545;6316.968415157895;6347.68261586928;6359.618422894641;10861.185411094042;10938.453077346101;11136;11163.665090047312;11260.324380537195;10800.51397687106;10819.188560857967;10939.398333091598;10977.780444391068;11065.668029958953;8456.323494120456;8589.957050214834;8711.869321960176;8744.213020828156;8804.603792829337;8074.39442041861;8110.918890811253;8137.226963438464;8138.83722325562;8401.83196336082;9556.952215239158;9701.417914925127;9828.5085745711;9837.409755414697;10023.649172278936;10059.29584929048;10344.741381465223;10420.06219440254;10464.529096190841;10517.789644207227;7880.84238315242;7898.881516777368;7912.9208707912185;7969.760907172794;7969.880451793344;8563.186497282748;8585.227329540372;8609.182127697859;8679.132086791271;8679.739607811776;7755.3407960324;7760.3403710685225;7844.64699088531;7915;7931.603419829101;7287.672054757442;7592.81017974555;7691.346235570039;7730.690772369042;7867.488613240121;6514.250861151028;7864;7929.246721561442;7944.364450844034;7957.602119893866;7036.718531258897;7098.148222213367;7121.608311542915;7140.500164988401;7144.67848946809;7197.244289349543;7247.202807691045;7266.237045110187;7277.927220727936;7280.635968201675 00:17:12 INFO - PROCESS | 1670 | |4;prototype.html;329.25259660570504;329.6867975423347;331.8025774664074;334.14625631511507;338.86445421831263;6941.895871561931;7022.192447868497;7029.472789540786;7034.9296507034915;7040.647967601625;6927;6932.341427564386;6958.373746362827;6986.790396288119;6991.0911581494465;4157.937630935538;4191.685623578229;4869.440014398354;4899.975500122495;5105.770240339184;5066.113430149728;5080.593552515808;5082.313887625179;5084.389873215219;5095.471358592407;5021.297018417406;5023.271625614284;5036.420811606676;5041.445441001487;5087.923681144785;4106.342985122381;4436.268015777393;4802.807887684488;5055.671381360218;5068.037072956164;3373.8481768320485;3566.7681600696133;4336.1978034063795;4338.8047537860875;4360.5203427623255;5604.570834437233;6471.223453185601;6475.449586785082;6494.642794646293;6653.3346665333565;5989.700514974277;6012.068129439944;6029.070697376841;6029.577929544934;6090.4518593326375;7350.926490735078;7364.852702945911;7377.557346559223;7401.740939067106;7407.1111466623815;4042.272390969624;4879.756012199411;4888.877778055577;4894.241392584155;4900.117978763821;7779;7810.336121429686;7813.335866451302;7826.908371193404;7832.647530861068;4592.678512504092;4773.928391074137;4775.904481910342;4776.331313616097;4942.308076869242;4826.975865120652;4851.320815085891;4872.82945096927;4885.633577481632;4896.1921282987905;5882.588218824641;5905.911411328833;5918.615290006136;5938.940610593925;5953.613015154087;7473.663685134182;7476;7476.813079672943;7484.9521067050655;7535.321821036133;1669.4073603870695;1685.5196269063258;1688.1559220389804;1689.5776055986003;1692.9915350423169;1028.3932479836933;1067.9587402282712;1076.1229597877705;1082.0694202985426;1085.5332207151;6833.145856767904;6861.382475577222;6898.172219333712;6899.6205208713;6910.378065974087;6175.814725558151;6854.314568543105;7144.3570078693165;7701.4608977371045;7763.378929685725;6239.625622462576;6615.966920165464;6761.22245941723;6950.131233595801;6966.686499107553;2945.8968936087135;4074.1444296698023;4127.277726397869;4140.565240649748;4142.792860357031;8057.798555036171;8118.675252989814;8137;8155.143709910492;8186;6574.605523668595;7784.2215778421705;8045.396595255379;8057.6374063167295;8063.153368896182;8030.357571394275;8195.467294625949;8202.425830191829;8202.753917382488;8222.13667564909;7848.7645370638975;7852.175521570153;7854.960725196566;7857.2928436441;7890.842183156419;7671.232876712284;7701.4608977371045;7705;7706.884396733942;7766.106897706836;7880.645370958436;8124.512529248264;8141.104478507478;8177.773333999948;8221.136780638186;4779.091972525209;4789.592884604847;4825.662203645711;4841.443234028132;4842.15262329098;7757;7773.533587984739;7782.5330480169105;7785.922140778746;7790.0651921767485;7445.590492522963;7458.067741532309;7485.401167906445;7502.349483113706;7505.962470187833;7167.3549380556;7210;7414;7446.180920098676;7468.551886886804;6263.686815659108;6283.868903597397;7325.120985481776;7339.119305683352;7371.41028717712;7466.887996679946;7467.253274672489;7474.402047836052;7491.43814213947;7506.924930750841;7035.155781306276;7291.708331666886;7295.489315748059;7297.16082650502;7321.890171647536 00:17:12 INFO - PROCESS | 1670 | |5;yui.html;698.5773606967784;759.6847308367028;763.4426868386078;763.7479631721533;778.6690656470998;15158.696826063471;15335.079895206267;15385.461508847193;15412.768808467868;15432.07407555546;15950.76073858893;16170.595735106628;16173.919130404362;16176.35294588215;16267.267972941216;758.7496126278315;902.6254104546605;929.907009299068;935.2798345274135;936.9599744283839;898.2993265253081;902.6795487601905;906.4425378392307;937.0208132501518;940.2759874896326;945.664289177339;953.9904600953971;972.8540718892152;988.214369576185;990.7671697151163;939.741571067955;939.9342046056779;943.4669411782321;985.6599473181741;986.2898712926717;696.9721211151548;700.1073631120362;701.4598758955626;713.425692317684;729.3727394440776;15383.538493845203;15499.457518986894;15716.135612541306;15742.842571574367;15780;12606.243625382507;12620.368981550977;12734.681632959158;12827.615171544869;12900;9652.372595781251;9743.269254805848;9745.463999480025;9795.412275263507;9798.216142708567;2923.6199294091844;3491.94762078569;3495.3009398120225;3496.73774466916;3506.1234691327168;82752.93117672046;84164.31671366538;85454;85564.57217713934;85714;7803.180666029985;9150.86273705895;9337.019612940543;9366.859497107549;9410.764730881783;20947.8952605236;21198;21478.57042859134;21934;21938;7327.230640782641;7344.559326440431;7416.184219735825;7546.094468663796;7627.656755445907;3996.541262439247;4009.298372784751;4027.516697996259;4029.9798501007895;4032.737872038308;3595.26297109092;3602.1895073608753;3603.7837729736298;3665.7983810890123;3670.284294562535;574.3022227992925;651.7295322441133;656.186328952096;656.1994366872408;663.9701213445406;488.68235646829845;507.42660793304066;541.2233445006428;591.5770224289654;623.0467384901109;7201.783946481614;7368.963155184297;7598.430117741192;8273.420860539705;8394.706185283485;507.2391412880679;510.75228514170595;620.3331418724889;625.1529177963794;634.5621521150391;3631.4371272452813;3685.2445248724484;3719.479272901796;3807.9428808567895;3932.783696896641;95201.04798952061;95463.04536954542;95815;97476.53785193228;97987;63836;79930.40139197299;81037;81352.77970830443;83108.337833243;72073.27926720666;72267.2773272271;74056.62971685214;74176;74945.25054749382;7100.893486597808;7129.597458678671;7133.678984445816;7193.633209690142;7320.084989376328;48492.272615910086;49437;49704;49711.00577988492;49829.750851246965;68833;70613;72560;72817.907731383;74008.62995684987;10058.899411006088;10112.342697724624;10119.898801011896;10160.23798215122;10625.149988001096;9566.330356874952;10791.082757965662;11052.668419947415;11095.778084438427;11216.719582010188;10322.587096516056;10340.327878687862;10449.634262800766;10478.266521343432;10857.294275872044;10292.022257885488;10309.688719051283;10527.526261318411;10655.57377704883;10723.142148627934;10226.795464090825;10278.280520363503;10301.536430860479;10319.587216511256;10368.637097701545;8766.517841518522;8957.865632015395;8989.685361012333;9169.128932751379;9229.861552076858;8872.822543549222;8973.820523589622;9010.459372437675;9027.687960761254;9052.004279529116 00:17:12 INFO - PROCESS | 1670 | __end_tp_report 00:17:12 INFO - PROCESS | 1670 | __start_cc_report 00:17:12 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,377 00:17:12 INFO - PROCESS | 1670 | __end_cc_report 00:17:12 INFO - PROCESS | 1670 | __startTimestamp1459322232218__endTimestamp 00:17:12 INFO - PROCESS | 1670 | 00:17:12 INFO - PROCESS | 1670 | ------- Summary: start ------- 00:17:12 INFO - PROCESS | 1670 | Number of tests: 6 00:17:12 INFO - PROCESS | 1670 | 00:17:12 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5716.01 Median:6031.55 stddev:673.67 (11.2%) stddev-sans-first:639.21 00:17:12 INFO - PROCESS | 1670 | Values: 2926.8 3515.4 3535.6 3557.3 3573.0 4756.0 5367.3 5591.3 5798.9 5825.8 4644.8 4715.7 5440.3 5599.8 5804.9 4320.4 5164.5 5184.3 5206.5 5355.8 5107.2 5317.2 5335.9 5349.4 5397.4 5166.1 5179.1 5215.6 5231.6 5242.8 5235.1 5236.9 5240.9 5253.3 5256.8 5186.7 5191.6 5195.8 5216.7 5243.8 4725.2 5407.1 5642.7 5684.6 5757.9 5571.0 5885.0 6178.8 6251.2 6276.7 6160.4 6236.5 6239.8 6262.3 6273.2 4638.6 5877.7 5919.1 5925.9 5956.6 5262.0 6280.4 6320.5 6321.2 6329.2 6101.5 6204.0 6233.9 6235.2 6249.0 6185.5 6216.0 6231.1 6233.5 6235.0 6040.5 6085.8 6113.5 6129.5 6162.2 6062.2 6147.6 6207.0 6207.1 6236.7 4928.4 4930.5 4939.5 4945.5 4979.1 4418.7 4422.2 4442.3 4445.2 4468.1 5835.3 5893.8 5909.9 5954.3 6019.5 6168.8 6192.9 6214.0 6227.5 6258.0 5938.6 5948.7 5956.6 5958.6 5990.8 5328.7 5411.1 5424.1 5457.6 5476.8 6334.3 6411.6 6414.6 6414.8 6416.3 6207.9 6215.3 6221.5 6225.1 6263.6 6175.7 6328.5 6339.4 6415.5 6415.5 6211.1 6213.4 6259.7 6263.4 6281.2 4784.8 5105.3 6216.0 6227.9 6264.6 6031.5 6105.1 6165.6 6172.2 6176.5 6083.6 6116.0 6164.0 6176.2 6180.0 5951.4 6032.8 6058.8 6101.8 6109.9 5617.4 6116.9 6120.9 6134.9 6215.0 6104.6 6120.3 6121.2 6126.2 6141.4 00:17:12 INFO - PROCESS | 1670 | 00:17:12 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:64386.25 Median:39295.31 stddev:134341.90 (341.9%) stddev-sans-first:134633.19 00:17:12 INFO - PROCESS | 1670 | Values: 522.2 536.9 556.0 586.9 594.9 38366.4 39293.4 39297.2 39354.8 39364.4 33547.5 41162.8 41565.0 41567.0 41757.0 9570.8 9722.0 9747.8 9764.0 9776.9 9520.0 9762.0 9770.8 9774.5 9815.3 9732.3 9832.3 9842.8 9857.0 9867.8 9732.7 9749.6 9827.4 9839.0 9850.5 8420.8 9630.7 9780.6 9800.5 9814.4 39105.8 39238.0 39318.6 39454.0 39884.0 3124.0 3229.5 3328.9 3411.7 3428.0 27820.7 27974.0 28905.4 29437.0 29587.9 2630.9 2722.5 2724.1 2736.0 2885.4 509676.0 512821.0 513072.0 513987.0 515093.0 46246.8 71401.0 71988.6 72246.6 72285.0 44914.0 45999.0 46256.8 46302.0 46338.8 15652.3 16016.5 16075.8 16175.1 16240.9 12555.8 12793.4 12854.4 12903.4 12964.5 14841.4 14936.8 15009.2 15047.1 15097.6 6354.6 6604.3 6638.4 6685.8 6695.5 952.6 982.3 1086.6 1113.5 1130.8 29791.7 29861.4 30114.8 30465.7 30489.8 1067.3 1089.6 1105.8 1118.5 1145.0 15175.5 15323.0 15361.0 15361.5 15462.3 521982.0 522456.0 523761.0 529659.0 530129.0 59554.4 60627.4 61795.7 61807.0 61807.1 1436.1 1475.5 1485.8 1491.6 1498.1 26446.0 28058.9 29452.7 29604.0 29606.3 39779.4 44538.1 44799.7 52999.5 53262.5 471432.0 474569.0 475057.0 475498.0 476369.0 34170.5 37842.4 41271.2 44622.0 46372.0 34569.0 44714.8 44833.3 44865.8 45169.9 26635.6 37186.4 37524.8 38101.4 38148.7 35459.8 36437.7 37019.0 38104.4 38725.6 37493.1 37842.8 37896.4 38364.4 38544.0 31626.4 33569.0 34211.3 34529.3 34623.0 24793.4 24967.3 25073.0 25414.2 25575.5 00:17:12 INFO - PROCESS | 1670 | 00:17:12 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:33838.16 Median:353.95 stddev:100693.10 (28448.5%) stddev-sans-first:100944.17 00:17:12 INFO - PROCESS | 1670 | Values: 351.6 356.3 357.0 360.9 361.0 19849.0 20164.6 21769.8 21843.3 21848.0 19966.6 20112.6 20586.3 20777.9 20847.5 4432.8 5249.4 5263.8 5268.7 5303.1 3921.3 5156.2 5668.9 5952.0 5964.3 5925.6 5939.8 5946.3 5947.8 5952.9 5732.2 5825.3 5858.3 5886.4 5890.1 5574.1 5601.4 5618.4 5630.1 5635.8 12862.8 17382.0 20275.7 25362.6 25427.5 1911.4 2063.9 2088.1 2167.3 2203.3 8199.3 9543.2 9970.6 9994.6 10098.9 1728.6 1755.6 1780.8 1781.6 1823.8 80693.0 97810.0 98528.0 99823.5 100186.0 10939.3 11027.4 11151.9 11302.0 11370.0 13417.1 13565.5 13591.3 13601.0 13619.0 7880.7 8543.1 8670.4 8686.2 8731.9 8555.5 8782.1 8792.2 8796.3 8867.0 3581.9 3664.0 4345.5 4434.6 4456.5 1609.3 1713.2 1774.3 1827.3 1859.0 863.7 866.4 884.9 955.7 988.8 18068.4 19623.5 20108.3 20112.4 20848.6 920.3 925.7 948.7 960.8 1024.1 10765.0 10873.4 10965.2 10980.8 11031.1 591784.0 602562.0 605044.0 621597.0 621937.9 108797.0 113346.4 113727.4 115020.0 116232.0 1018.1 1039.1 1045.4 1048.0 1067.7 17788.6 17843.3 18387.6 18615.8 19425.2 51996.7 53046.0 53337.0 53631.7 54497.0 70796.0 70820.0 72030.6 72586.3 73152.6 7626.5 7816.3 7892.0 7989.6 8195.2 11872.9 12446.8 12524.9 12717.6 12851.0 9014.7 10977.1 11164.7 11418.7 11426.8 11065.4 11077.3 11110.0 11175.1 11344.1 9857.4 11390.9 11485.4 11540.8 11668.2 7626.8 7942.3 7976.7 8038.4 8088.4 9710.9 11035.2 11061.3 11095.9 11392.3 00:17:12 INFO - PROCESS | 1670 | 00:17:12 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:6233.09 Median:5073.34 stddev:3357.47 (66.2%) stddev-sans-first:3349.16 00:17:12 INFO - PROCESS | 1670 | Values: 1643.0 1667.6 1851.7 2025.6 2025.9 8122.0 8834.4 8869.2 9018.5 9019.5 8917.6 8941.8 8956.6 9036.6 9076.4 2498.3 2514.7 2521.0 2525.8 2544.6 2460.8 2529.9 2537.1 2538.9 2539.0 2484.4 2509.3 2511.8 2536.3 2547.7 2481.0 2481.4 2491.6 2516.8 2527.0 2494.6 2522.6 2525.3 2525.8 2540.2 9100.7 9195.0 9258.4 9259.0 9286.8 5545.6 5607.2 5646.2 5786.8 5817.9 2948.6 3114.9 3641.8 3772.2 3808.4 1071.3 1088.5 1090.1 1090.5 1090.6 12246.6 12482.8 12547.4 12560.1 12586.9 5013.5 5015.2 5031.7 5114.9 5114.9 10570.8 10581.4 10602.2 10645.6 10656.3 4566.3 5560.3 5666.9 5672.8 5681.8 4067.5 4361.9 4406.9 4576.2 4578.2 3344.6 3421.9 3953.3 4012.8 4083.0 1320.8 1325.2 1330.0 1342.6 1351.4 1331.0 1361.2 1383.3 1402.4 1410.2 8345.8 8389.8 8527.0 8535.4 8543.6 460.7 522.7 532.1 535.6 540.6 6253.1 6297.7 6317.0 6347.7 6359.6 10861.2 10938.5 11136.0 11163.7 11260.3 10800.5 10819.2 10939.4 10977.8 11065.7 8456.3 8590.0 8711.9 8744.2 8804.6 8074.4 8110.9 8137.2 8138.8 8401.8 9557.0 9701.4 9828.5 9837.4 10023.6 10059.3 10344.7 10420.1 10464.5 10517.8 7880.8 7898.9 7912.9 7969.8 7969.9 8563.2 8585.2 8609.2 8679.1 8679.7 7755.3 7760.3 7844.6 7915.0 7931.6 7287.7 7592.8 7691.3 7730.7 7867.5 6514.3 7864.0 7929.2 7944.4 7957.6 7036.7 7098.1 7121.6 7140.5 7144.7 7197.2 7247.2 7266.2 7277.9 7280.6 00:17:12 INFO - PROCESS | 1670 | 00:17:12 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:6033.25 Median:6898.90 stddev:2001.76 (29.0%) stddev-sans-first:1961.06 00:17:12 INFO - PROCESS | 1670 | Values: 329.3 329.7 331.8 334.1 338.9 6941.9 7022.2 7029.5 7034.9 7040.6 6927.0 6932.3 6958.4 6986.8 6991.1 4157.9 4191.7 4869.4 4900.0 5105.8 5066.1 5080.6 5082.3 5084.4 5095.5 5021.3 5023.3 5036.4 5041.4 5087.9 4106.3 4436.3 4802.8 5055.7 5068.0 3373.8 3566.8 4336.2 4338.8 4360.5 5604.6 6471.2 6475.4 6494.6 6653.3 5989.7 6012.1 6029.1 6029.6 6090.5 7350.9 7364.9 7377.6 7401.7 7407.1 4042.3 4879.8 4888.9 4894.2 4900.1 7779.0 7810.3 7813.3 7826.9 7832.6 4592.7 4773.9 4775.9 4776.3 4942.3 4827.0 4851.3 4872.8 4885.6 4896.2 5882.6 5905.9 5918.6 5938.9 5953.6 7473.7 7476.0 7476.8 7485.0 7535.3 1669.4 1685.5 1688.2 1689.6 1693.0 1028.4 1068.0 1076.1 1082.1 1085.5 6833.1 6861.4 6898.2 6899.6 6910.4 6175.8 6854.3 7144.4 7701.5 7763.4 6239.6 6616.0 6761.2 6950.1 6966.7 2945.9 4074.1 4127.3 4140.6 4142.8 8057.8 8118.7 8137.0 8155.1 8186.0 6574.6 7784.2 8045.4 8057.6 8063.2 8030.4 8195.5 8202.4 8202.8 8222.1 7848.8 7852.2 7855.0 7857.3 7890.8 7671.2 7701.5 7705.0 7706.9 7766.1 7880.6 8124.5 8141.1 8177.8 8221.1 4779.1 4789.6 4825.7 4841.4 4842.2 7757.0 7773.5 7782.5 7785.9 7790.1 7445.6 7458.1 7485.4 7502.3 7506.0 7167.4 7210.0 7414.0 7446.2 7468.6 6263.7 6283.9 7325.1 7339.1 7371.4 7466.9 7467.3 7474.4 7491.4 7506.9 7035.2 7291.7 7295.5 7297.2 7321.9 00:17:12 INFO - PROCESS | 1670 | 00:17:12 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:18561.16 Median:34764.99 stddev:26773.24 (77.0%) stddev-sans-first:26814.75 00:17:12 INFO - PROCESS | 1670 | Values: 698.6 759.7 763.4 763.7 778.7 15158.7 15335.1 15385.5 15412.8 15432.1 15950.8 16170.6 16173.9 16176.4 16267.3 758.7 902.6 929.9 935.3 937.0 898.3 902.7 906.4 937.0 940.3 945.7 954.0 972.9 988.2 990.8 939.7 939.9 943.5 985.7 986.3 697.0 700.1 701.5 713.4 729.4 15383.5 15499.5 15716.1 15742.8 15780.0 12606.2 12620.4 12734.7 12827.6 12900.0 9652.4 9743.3 9745.5 9795.4 9798.2 2923.6 3491.9 3495.3 3496.7 3506.1 82752.9 84164.3 85454.0 85564.6 85714.0 7803.2 9150.9 9337.0 9366.9 9410.8 20947.9 21198.0 21478.6 21934.0 21938.0 7327.2 7344.6 7416.2 7546.1 7627.7 3996.5 4009.3 4027.5 4030.0 4032.7 3595.3 3602.2 3603.8 3665.8 3670.3 574.3 651.7 656.2 656.2 664.0 488.7 507.4 541.2 591.6 623.0 7201.8 7369.0 7598.4 8273.4 8394.7 507.2 510.8 620.3 625.2 634.6 3631.4 3685.2 3719.5 3807.9 3932.8 95201.0 95463.0 95815.0 97476.5 97987.0 63836.0 79930.4 81037.0 81352.8 83108.3 72073.3 72267.3 74056.6 74176.0 74945.3 7100.9 7129.6 7133.7 7193.6 7320.1 48492.3 49437.0 49704.0 49711.0 49829.8 68833.0 70613.0 72560.0 72817.9 74008.6 10058.9 10112.3 10119.9 10160.2 10625.1 9566.3 10791.1 11052.7 11095.8 11216.7 10322.6 10340.3 10449.6 10478.3 10857.3 10292.0 10309.7 10527.5 10655.6 10723.1 10226.8 10278.3 10301.5 10319.6 10368.6 8766.5 8957.9 8989.7 9169.1 9229.9 8872.8 8973.8 9010.5 9027.7 9052.0 00:17:12 INFO - PROCESS | 1670 | -------- Summary: end -------- 00:17:12 INFO - PROCESS | 1670 | 00:17:12 INFO - TEST-INFO | 1670: exit 0 00:17:12 INFO - TEST-OK | dromaeo_css | took 1111455ms 00:17:12 INFO - TEST-START | kraken 00:17:12 INFO - operating with platform_type : mac_ 00:17:12 INFO - Initialising browser for kraken test... 00:17:12 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpYt8nLl/profile http://localhost:49276/getInfo.html) 00:17:15 INFO - PROCESS | 1679 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 00:17:15 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 00:17:15 INFO - PROCESS | 1679 | colorDepth:24 00:17:15 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 00:17:15 INFO - PROCESS | 1679 | __metrics 00:17:15 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 00:17:16 INFO - TEST-INFO | 1679: exit 0 00:17:16 INFO - Browser initialized. 00:17:16 INFO - Running cycle 1/1 for kraken test... 00:17:16 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpYt8nLl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:17:28 INFO - PROCESS | 1682 | RSS: Main: 254529536 00:17:28 INFO - PROCESS | 1682 | 00:17:31 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 00:17:31 INFO - PROCESS | 1682 | RSS: Main: 266919936 00:17:31 INFO - PROCESS | 1682 | 00:17:34 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 00:17:35 INFO - PROCESS | 1682 | RSS: Main: 275947520 00:17:35 INFO - PROCESS | 1682 | 00:17:38 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 00:17:39 INFO - PROCESS | 1682 | RSS: Main: 279220224 00:17:39 INFO - PROCESS | 1682 | 00:17:41 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 00:17:41 INFO - PROCESS | 1682 | RSS: Main: 281141248 00:17:41 INFO - PROCESS | 1682 | 00:17:43 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:17:44 INFO - PROCESS | 1682 | RSS: Main: 281554944 00:17:44 INFO - PROCESS | 1682 | 00:17:47 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 00:17:47 INFO - PROCESS | 1682 | RSS: Main: 282726400 00:17:47 INFO - PROCESS | 1682 | 00:17:50 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 00:17:51 INFO - PROCESS | 1682 | RSS: Main: 282587136 00:17:51 INFO - PROCESS | 1682 | 00:17:54 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 00:17:54 INFO - PROCESS | 1682 | RSS: Main: 282611712 00:17:54 INFO - PROCESS | 1682 | 00:17:56 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:17:57 INFO - PROCESS | 1682 | RSS: Main: 281903104 00:17:57 INFO - PROCESS | 1682 | 00:17:59 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:17:59 INFO - PROCESS | 1682 | RSS: Main: 282128384 00:17:59 INFO - PROCESS | 1682 | 00:18:02 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:18:02 INFO - PROCESS | 1682 | RSS: Main: 282263552 00:18:02 INFO - PROCESS | 1682 | 00:18:05 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:18:05 INFO - PROCESS | 1682 | RSS: Main: 282238976 00:18:05 INFO - PROCESS | 1682 | 00:18:08 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:18:09 INFO - PROCESS | 1682 | RSS: Main: 282210304 00:18:09 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 00:18:11 INFO - PROCESS | 1682 | RSS: Main: 283643904 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | __start_tp_report 00:18:11 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 00:18:11 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 00:18:11 INFO - PROCESS | 1682 | |i|pagename|runs| 00:18:11 INFO - PROCESS | 1682 | |0;ai-astar;115;119;168;168;127;127;114;116;124;167 00:18:11 INFO - PROCESS | 1682 | |1;audio-beat-detection;152;123;143;192;151;141;124;153;149;120 00:18:11 INFO - PROCESS | 1682 | |2;audio-dft;186;221;196;204;215;220;200;281;183;270 00:18:11 INFO - PROCESS | 1682 | |3;audio-fft;68;70;75;114;74;79;85;87;153;56 00:18:11 INFO - PROCESS | 1682 | |4;audio-oscillator;86;64;109;60;65;74;145;124;117;158 00:18:11 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;89;101;133;87;89;85;89;87;90;86 00:18:11 INFO - PROCESS | 1682 | |6;imaging-darkroom;149;95;95;95;95;95;95;120;143;99 00:18:11 INFO - PROCESS | 1682 | |7;imaging-desaturate;90;97;91;99;94;89;90;96;90;91 00:18:11 INFO - PROCESS | 1682 | |8;json-parse-financial;57;62;67;86;87;82;69;60;48;54 00:18:11 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;67;73;105;76;79;76;73;73;88;60 00:18:11 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;92;112;118;113;84;83;97;72;104;95 00:18:11 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;133;133;136;120;149;160;136;130;123;138 00:18:11 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;131;136;138;142;139;130;155;185;177;177 00:18:11 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;67;74;100;91;58;57;90;101;97;99 00:18:11 INFO - PROCESS | 1682 | __end_tp_report 00:18:11 INFO - PROCESS | 1682 | __start_cc_report 00:18:11 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,950 00:18:11 INFO - PROCESS | 1682 | __end_cc_report 00:18:11 INFO - PROCESS | 1682 | __startTimestamp1459322291260__endTimestamp 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | ------- Summary: start ------- 00:18:11 INFO - PROCESS | 1682 | Number of tests: 14 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:134.50 Median:127.00 stddev:23.35 (18.4%) stddev-sans-first:23.67 00:18:11 INFO - PROCESS | 1682 | Values: 115.0 119.0 168.0 168.0 127.0 127.0 114.0 116.0 124.0 167.0 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:150.00 stddev:20.93 (14.0%) stddev-sans-first:22.04 00:18:11 INFO - PROCESS | 1682 | Values: 152.0 123.0 143.0 192.0 151.0 141.0 124.0 153.0 149.0 120.0 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:217.60 Median:217.50 stddev:33.24 (15.3%) stddev-sans-first:33.24 00:18:11 INFO - PROCESS | 1682 | Values: 186.0 221.0 196.0 204.0 215.0 220.0 200.0 281.0 183.0 270.0 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:86.10 Median:74.50 stddev:28.03 (37.6%) stddev-sans-first:28.95 00:18:11 INFO - PROCESS | 1682 | Values: 68.0 70.0 75.0 114.0 74.0 79.0 85.0 87.0 153.0 56.0 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:100.20 Median:62.00 stddev:35.48 (57.2%) stddev-sans-first:37.26 00:18:11 INFO - PROCESS | 1682 | Values: 86.0 64.0 109.0 60.0 65.0 74.0 145.0 124.0 117.0 158.0 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:93.60 Median:88.00 stddev:14.54 (16.5%) stddev-sans-first:15.33 00:18:11 INFO - PROCESS | 1682 | Values: 89.0 101.0 133.0 87.0 89.0 85.0 89.0 87.0 90.0 86.0 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:108.10 Median:95.00 stddev:21.46 (22.6%) stddev-sans-first:16.90 00:18:11 INFO - PROCESS | 1682 | Values: 149.0 95.0 95.0 95.0 95.0 95.0 95.0 120.0 143.0 99.0 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:92.70 Median:92.50 stddev:3.53 (3.8%) stddev-sans-first:3.61 00:18:11 INFO - PROCESS | 1682 | Values: 90.0 97.0 91.0 99.0 94.0 89.0 90.0 96.0 90.0 91.0 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:68.00 stddev:13.72 (20.2%) stddev-sans-first:14.04 00:18:11 INFO - PROCESS | 1682 | Values: 57.0 62.0 67.0 86.0 87.0 82.0 69.0 60.0 48.0 54.0 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:77.00 Median:74.50 stddev:12.24 (16.4%) stddev-sans-first:12.43 00:18:11 INFO - PROCESS | 1682 | Values: 67.0 73.0 105.0 76.0 79.0 76.0 73.0 73.0 88.0 60.0 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:97.00 Median:83.50 stddev:14.87 (17.8%) stddev-sans-first:15.66 00:18:11 INFO - PROCESS | 1682 | Values: 92.0 112.0 118.0 113.0 84.0 83.0 97.0 72.0 104.0 95.0 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:136.00 stddev:11.68 (8.6%) stddev-sans-first:12.34 00:18:11 INFO - PROCESS | 1682 | Values: 133.0 133.0 136.0 120.0 149.0 160.0 136.0 130.0 123.0 138.0 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.00 Median:148.50 stddev:21.04 (14.2%) stddev-sans-first:21.03 00:18:11 INFO - PROCESS | 1682 | Values: 131.0 136.0 138.0 142.0 139.0 130.0 155.0 185.0 177.0 177.0 00:18:11 INFO - PROCESS | 1682 | 00:18:11 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.40 Median:82.00 stddev:17.68 (21.6%) stddev-sans-first:17.73 00:18:11 INFO - PROCESS | 1682 | Values: 67.0 74.0 100.0 91.0 58.0 57.0 90.0 101.0 97.0 99.0 00:18:11 INFO - PROCESS | 1682 | -------- Summary: end -------- 00:18:11 INFO - PROCESS | 1682 | 00:18:12 INFO - TEST-INFO | 1682: exit 0 00:18:12 INFO - TEST-OK | kraken | took 59449ms 00:18:12 INFO - SUITE-END | took 1170s 00:18:12 INFO - Completed test suite (00:19:31) 00:18:12 INFO - javascript benchmark 00:18:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2926.809757365771, 3515.4375299952003, 3535.575730912291, 3557.270759494304, 3572.964270357299, 4755.976220118894, 5367.275417818598, 5591.329040515144, 5798.942010579898, 5825.796097136596, 4644.837430689927, 4715.693479923802, 5440.319960004999, 5599.832005039855, 5804.941950580493, 4320.416743739586, 5164.45773193814, 5184.274201611777, 5206.505381988705, 5355.7857685692525, 5107.157319042353, 5317.202419637047, 5335.893282134355, 5349.384820745606, 5397.4062853086325, 5166.1217593008905, 5179.14544100223, 5215.608829337796, 5231.633785635007, 5242.8165014224505, 5235.136202526579, 5236.895262094737, 5240.925610249928, 5253.343332083489, 5256.789728410859, 5186.7147306898105, 5191.558717509016, 5195.766190521435, 5216.686998780047, 5243.842684719426, 4725.196716558194, 5407.107827208506, 5642.689652069134, 5684.602077854552, 5757.913631295534, 5570.972145139248, 5884.970575147139, 6178.752849885999, 6251.156093927352, 6276.686165691697, 6160.383961603804, 6236.532260080467, 6239.750409983641, 6262.342454042306, 6273.247210334744, 4638.628909687217, 5877.706114694291, 5919.112133180014, 5925.881482370329, 5956.5532585055425, 5262.0, 6280.371962803774, 6320.525960552977, 6321.209848768904, 6329.208848893888, 6101.450869421685, 6203.96898015507, 6233.937660623426, 6235.158253635792, 6249.031400132987, 6185.474234690012, 6216.0, 6231.096491008779, 6233.501319894398, 6235.0, 6040.516758659297, 6085.756569737249, 6113.467391846696, 6129.540284478682, 6162.198914141133, 6062.211912451441, 6147.600405973598, 6206.968965155145, 6207.131001659771, 6236.719347629368, 4928.433230178575, 4930.5069493050405, 4939.481354457802, 4945.530174633404, 4979.128652485801, 4418.690691651618, 4422.226110430662, 4442.2892337225885, 4445.1998640245065, 4468.106378724268, 5835.328937172195, 5893.823185304362, 5909.852253693692, 5954.315253745788, 6019.458248757633, 6168.845778855564, 6192.938070619326, 6214.005759078525, 6227.532935029801, 6258.0, 5938.6436813791315, 5948.702564871739, 5956.583039187302, 5958.553108516879, 5990.820275391745, 5328.706921119376, 5411.134218525017, 5424.077906755861, 5457.645253058538, 5476.7535460903555, 6334.271558770801, 6411.6153030818305, 6414.550981431255, 6414.807555773335, 6416.294207637063, 6207.875842483216, 6215.34738852414, 6221.502279817513, 6225.097360882556, 6263.592866463665, 6175.660338681416, 6328.493720502257, 6339.366063393623, 6415.454686351526, 6415.486761059011, 6211.09939058843, 6213.37866213375, 6259.718312676032, 6263.3736626337, 6281.183446151971, 4784.760761961818, 5105.336306280308, 6215.96892015537, 6227.906581401192, 6264.59280146789, 6031.5476339273855, 6105.053716673922, 6165.599236049642, 6172.22847144107, 6176.505879529716, 6083.6349819011, 6115.970584430425, 6163.96918015407, 6176.166217560572, 6180.0, 5951.375105613848, 6032.819015429544, 6058.818235452944, 6101.84745381369, 6109.877802443837, 5617.382087970238, 6116.914073580098, 6120.9347721082095, 6134.877302454015, 6215.005599104122, 6104.578931152009, 6120.2947619997085, 6121.178620693132, 6126.214173165583, 6141.385861413823], "unit": "score", "name": "dojo.html", "value": 5675.215214972692}, {"lowerIsBetter": false, "replicates": [522.2244966225155, 536.9047143826594, 556.0214023318958, 586.9054213891093, 594.8661551150991, 38366.424503632436, 39293.410598841, 39297.21405571887, 39354.8032259839, 39364.40953385698, 33547.4967875482, 41162.76511704646, 41565.0, 41567.0, 41757.0, 9570.760730981729, 9721.951390243039, 9747.805043899118, 9764.023597640251, 9776.853347199798, 9520.047995200493, 9761.97499262578, 9770.804583908317, 9774.462404567746, 9815.263855210887, 9732.318737688365, 9832.31173817833, 9842.753931151707, 9857.014298570122, 9867.802643947116, 9732.65935692251, 9749.561269742808, 9827.4103553787, 9839.016098390175, 9850.50747462631, 8420.789480262982, 9630.711078667651, 9780.608775648965, 9800.460974646392, 9814.362066465728, 39105.804470977746, 39238.019049523704, 39318.60681393178, 39454.0136496587, 39884.0, 3123.9843800781077, 3229.46713792224, 3328.9334213315597, 3411.710004649583, 3428.0230134411822, 27820.721792782017, 27974.02090926828, 28905.42189156205, 29437.0, 29587.852060739773, 2630.921072367832, 2722.469118521889, 2724.1146627346193, 2735.9726402736114, 2885.365219651673, 509676.0, 512821.0, 513071.9999999963, 513987.0, 515093.0, 46246.768766155954, 71401.0, 71988.64005680043, 72246.63876680583, 72285.0, 44914.0, 45999.0, 46256.768716156206, 46302.0, 46338.76830615825, 15652.295646695926, 16016.519504414886, 16075.758863617055, 16175.110368929587, 16240.918795405947, 12555.811662825065, 12793.42429590652, 12854.357282135856, 12903.419346129447, 12964.481420743254, 14841.40634374613, 14936.775948360782, 15009.174495402858, 15047.097174169585, 15097.622559436102, 6354.586951848115, 6604.306547812506, 6638.4357329626555, 6685.827106190508, 6695.497837662195, 952.5808644196532, 982.2633025230933, 1086.5816660585574, 1113.5156207049959, 1130.8077626803463, 29791.702082978893, 29861.402771944875, 30114.84942575273, 30465.695343046285, 30489.847550762548, 1067.2529229539352, 1089.5859573362072, 1105.8230683090667, 1118.4687273545, 1144.9942750286195, 15175.544733658007, 15323.0, 15361.0, 15361.462348817739, 15462.28312674025, 521982.0, 522456.0, 523761.0, 529659.0, 530129.0, 59554.40445595575, 60627.393726062175, 61795.691021544604, 61807.0, 61807.055435565046, 1436.1454934314067, 1475.4762059468949, 1485.843986381436, 1491.6047247479426, 1498.1161114942236, 26446.0, 28058.85970570134, 29452.705472944996, 29603.963861264754, 29606.259843503223, 39779.40330895097, 44538.10923781571, 44799.65601031974, 52999.47000529945, 53262.46737532575, 471432.0, 474569.0, 475057.0, 475498.0, 476369.0, 34170.48744268888, 37842.43236351402, 41271.1745765077, 44622.0, 46372.0, 34569.0, 44714.77642611766, 44833.327500086874, 44865.77567112144, 45169.87075323012, 26635.600465992637, 37186.44220336643, 37524.812375937945, 38101.4284785734, 38148.66479673198, 35459.82270088633, 36437.724679636085, 37019.0, 38104.428433574074, 38725.61274387333, 37493.062673433385, 37842.81078594589, 37896.43155352617, 38364.42453363258, 38544.0, 31626.36747265088, 33568.99293021213, 34211.31577368489, 34529.30941381209, 34623.0, 24793.380165496008, 24967.250982470556, 25073.0, 25414.237572872844, 25575.48849022972], "unit": "score", "name": "ext.html", "value": 19549.78292446126}, {"lowerIsBetter": false, "replicates": [351.6307876729432, 356.2660918507873, 356.9839357228925, 360.91879327151395, 361.0036498165148, 19849.007549622533, 20164.59670806583, 21769.802660853646, 21843.344699659017, 21848.0, 19966.600667986633, 20112.597748045067, 20586.279480218196, 20777.896110519465, 20847.47881302968, 4432.778361081949, 5249.396319423258, 5263.789448422059, 5268.710220937847, 5303.124984377573, 3921.29416704993, 5156.175011998081, 5668.858278543049, 5952.0, 5964.314103878044, 5925.5555833312455, 5939.7921072762465, 5946.256717910262, 5947.7620895164355, 5952.851178720523, 5732.22614946981, 5825.30096388434, 5858.2677165354335, 5886.411358864122, 5890.145928840337, 5574.052411090124, 5601.383847776741, 5618.353889302701, 5630.071038278679, 5635.80274690388, 12862.807057894139, 17382.001069876875, 20275.695864562043, 25362.619560706604, 25427.49145017089, 1911.4361263427322, 2063.8658487198286, 2088.0812442525394, 2167.2522979572022, 2203.294945617403, 8199.344052475788, 9543.188828949478, 9970.551325190383, 9994.600215991424, 10098.89901100987, 1728.5592173995676, 1755.6488702259599, 1780.8486278666328, 1781.6169523552499, 1823.8176182381787, 80693.0, 97810.0, 98528.0, 99823.50088249512, 100185.99442016751, 10939.28894621847, 11027.393493357782, 11151.944240278746, 11302.0, 11370.0, 13417.127886687334, 13565.525206617722, 13591.252481113435, 13601.0, 13619.0, 7880.724174653859, 8543.102974187621, 8670.393072484992, 8686.218240358397, 8731.912680873236, 8555.486670799772, 8782.121787821166, 8792.241551689687, 8796.34027447944, 8866.955665221632, 3581.94627080594, 3663.9633603663624, 4345.478542574911, 4434.578715022068, 4456.46522417312, 1609.2597405193742, 1713.1605513298643, 1774.2636805725738, 1827.2873579304082, 1858.990705046466, 863.7495126413395, 866.4281574161149, 884.8849649545647, 955.6941778630771, 988.7923536057365, 18068.36760713369, 19623.50941226452, 20108.296209632885, 20112.379771641245, 20848.58302833965, 920.2545937790411, 925.7407925780792, 948.6537413843897, 960.8270511308032, 1024.0987930621006, 10764.977327153907, 10873.401962892116, 10965.177611679155, 10980.780384392427, 11031.062359699356, 591784.0, 602562.0, 605044.0, 621597.0, 621937.8903105456, 108797.0, 113346.43326783313, 113727.43136284266, 115020.0, 116232.0, 1018.063381688848, 1039.0856046678873, 1045.383223897904, 1047.994760026195, 1067.6583493282076, 17788.598539197043, 17843.286268549113, 18387.632247355246, 18615.813841861407, 19425.222991080198, 51996.74001629968, 53046.0, 53337.0, 53631.731841340545, 54497.0, 70796.0, 70820.0, 72030.63984680253, 72586.27413725795, 73152.63423682848, 7626.466147369631, 7816.296533312029, 7892.0, 7989.640466178919, 8195.221453961864, 11872.881271187523, 12446.751064978831, 12524.935380492396, 12717.55488557896, 12851.0, 9014.684486042957, 10977.121830253402, 11164.665060048212, 11418.714532136763, 11426.771464570827, 11065.446727663424, 11077.279976801483, 11110.0, 11175.105991520497, 11344.149188811038, 9857.408555486694, 11390.943045284721, 11485.425728713364, 11540.769184616092, 11668.241564298294, 7626.809329766578, 7942.285194332538, 7976.7208147714555, 8038.437309388521, 8088.393370497119, 9710.854337184806, 11035.227534072537, 11061.281016733887, 11095.88904110981, 11392.316461012366], "unit": "score", "name": "jquery.html", "value": 9201.359932884288}, {"lowerIsBetter": false, "replicates": [1642.9835701642983, 1667.5580971042673, 1851.7222416637503, 2025.5543780368314, 2025.9290924817635, 8122.0, 8834.381593288472, 8869.201771840533, 9018.549072546371, 9019.503927283997, 8917.554122293892, 8941.821163576724, 8956.596953137108, 9036.5933532991, 9076.36465447419, 2498.275500104972, 2514.660520829683, 2520.987395063022, 2525.848449093051, 2544.580144276192, 2460.778529932306, 2529.949401011979, 2537.0739680016845, 2538.9111381101666, 2538.9746102539016, 2484.366486545928, 2509.335026218054, 2511.7613826686434, 2536.340551456616, 2547.7197508274076, 2480.957997640995, 2481.4416756229793, 2491.6137998610243, 2516.798656107507, 2527.0397249045427, 2494.550980823451, 2522.646829443879, 2525.3181640957023, 2525.7726804587674, 2540.174443305933, 9100.681476148304, 9194.954025229898, 9258.444493330422, 9259.0, 9286.767830804216, 5545.584081193927, 5607.158926161068, 5646.20953066571, 5786.797462088806, 5817.912731308991, 2948.5871977923107, 3114.8909788157307, 3641.799701016443, 3772.2078363543687, 3808.428735689641, 1071.2929466552039, 1088.4775307852196, 1090.0679918669582, 1090.487470888681, 1090.6400887707039, 12246.571370002008, 12482.75034499305, 12547.372631368395, 12560.057995650362, 12586.874131258663, 5013.473585273567, 5015.247712843103, 5031.723255220924, 5114.948850511447, 5114.948850511521, 10570.788584228272, 10581.418022008864, 10602.204834637432, 10645.627403040857, 10656.25406221557, 4566.315052742115, 5560.332760068818, 5666.914996275059, 5672.829815105553, 5681.829545113653, 4067.491563554556, 4361.9127617447475, 4406.867793966187, 4576.176288268143, 4578.198815207392, 3344.6320904700465, 3421.8973430797114, 3953.2686453006286, 4012.779297138627, 4082.9795851020554, 1320.8442612713875, 1325.2379881567945, 1329.9800502992464, 1342.6307765364602, 1351.3716122003316, 1330.966725831862, 1361.2241022617013, 1383.3152589468277, 1402.4109873853006, 1410.2102822419479, 8345.791355216168, 8389.832203355898, 8526.957365213135, 8535.445196062235, 8543.572821358906, 460.70745076876426, 522.7020598259032, 532.1113740054119, 535.5742184962963, 540.5972550449861, 6253.093301471261, 6297.6536290503545, 6316.968415157895, 6347.68261586928, 6359.618422894641, 10861.185411094042, 10938.453077346101, 11136.0, 11163.665090047312, 11260.324380537195, 10800.51397687106, 10819.188560857967, 10939.398333091598, 10977.780444391068, 11065.668029958953, 8456.323494120456, 8589.957050214834, 8711.869321960176, 8744.213020828156, 8804.603792829337, 8074.39442041861, 8110.918890811253, 8137.226963438464, 8138.83722325562, 8401.83196336082, 9556.952215239158, 9701.417914925127, 9828.5085745711, 9837.409755414697, 10023.649172278936, 10059.29584929048, 10344.741381465223, 10420.06219440254, 10464.529096190841, 10517.789644207227, 7880.84238315242, 7898.881516777368, 7912.9208707912185, 7969.760907172794, 7969.880451793344, 8563.186497282748, 8585.227329540372, 8609.182127697859, 8679.132086791271, 8679.739607811776, 7755.3407960324, 7760.3403710685225, 7844.64699088531, 7915.0, 7931.603419829101, 7287.672054757442, 7592.81017974555, 7691.346235570039, 7730.690772369042, 7867.488613240121, 6514.250861151028, 7864.0, 7929.246721561442, 7944.364450844034, 7957.602119893866, 7036.718531258897, 7098.148222213367, 7121.608311542915, 7140.500164988401, 7144.67848946809, 7197.244289349543, 7247.202807691045, 7266.237045110187, 7277.927220727936, 7280.635968201675], "unit": "score", "name": "mootools.html", "value": 4977.97802774473}, {"lowerIsBetter": false, "replicates": [329.25259660570504, 329.6867975423347, 331.8025774664074, 334.14625631511507, 338.86445421831263, 6941.895871561931, 7022.192447868497, 7029.472789540786, 7034.9296507034915, 7040.647967601625, 6927.0, 6932.341427564386, 6958.373746362827, 6986.790396288119, 6991.0911581494465, 4157.937630935538, 4191.685623578229, 4869.440014398354, 4899.975500122495, 5105.770240339184, 5066.113430149728, 5080.593552515808, 5082.313887625179, 5084.389873215219, 5095.471358592407, 5021.297018417406, 5023.271625614284, 5036.420811606676, 5041.445441001487, 5087.923681144785, 4106.342985122381, 4436.268015777393, 4802.807887684488, 5055.671381360218, 5068.037072956164, 3373.8481768320485, 3566.7681600696133, 4336.1978034063795, 4338.8047537860875, 4360.5203427623255, 5604.570834437233, 6471.223453185601, 6475.449586785082, 6494.642794646293, 6653.3346665333565, 5989.700514974277, 6012.068129439944, 6029.070697376841, 6029.577929544934, 6090.4518593326375, 7350.926490735078, 7364.852702945911, 7377.557346559223, 7401.740939067106, 7407.1111466623815, 4042.272390969624, 4879.756012199411, 4888.877778055577, 4894.241392584155, 4900.117978763821, 7779.0, 7810.336121429686, 7813.335866451302, 7826.908371193404, 7832.647530861068, 4592.678512504092, 4773.928391074137, 4775.904481910342, 4776.331313616097, 4942.308076869242, 4826.975865120652, 4851.320815085891, 4872.82945096927, 4885.633577481632, 4896.1921282987905, 5882.588218824641, 5905.911411328833, 5918.615290006136, 5938.940610593925, 5953.613015154087, 7473.663685134182, 7476.0, 7476.813079672943, 7484.9521067050655, 7535.321821036133, 1669.4073603870695, 1685.5196269063258, 1688.1559220389804, 1689.5776055986003, 1692.9915350423169, 1028.3932479836933, 1067.9587402282712, 1076.1229597877705, 1082.0694202985426, 1085.5332207151, 6833.145856767904, 6861.382475577222, 6898.172219333712, 6899.6205208713, 6910.378065974087, 6175.814725558151, 6854.314568543105, 7144.3570078693165, 7701.4608977371045, 7763.378929685725, 6239.625622462576, 6615.966920165464, 6761.22245941723, 6950.131233595801, 6966.686499107553, 2945.8968936087135, 4074.1444296698023, 4127.277726397869, 4140.565240649748, 4142.792860357031, 8057.798555036171, 8118.675252989814, 8137.0, 8155.143709910492, 8186.0, 6574.605523668595, 7784.2215778421705, 8045.396595255379, 8057.6374063167295, 8063.153368896182, 8030.357571394275, 8195.467294625949, 8202.425830191829, 8202.753917382488, 8222.13667564909, 7848.7645370638975, 7852.175521570153, 7854.960725196566, 7857.2928436441, 7890.842183156419, 7671.232876712284, 7701.4608977371045, 7705.0, 7706.884396733942, 7766.106897706836, 7880.645370958436, 8124.512529248264, 8141.104478507478, 8177.773333999948, 8221.136780638186, 4779.091972525209, 4789.592884604847, 4825.662203645711, 4841.443234028132, 4842.15262329098, 7757.0, 7773.533587984739, 7782.5330480169105, 7785.922140778746, 7790.0651921767485, 7445.590492522963, 7458.067741532309, 7485.401167906445, 7502.349483113706, 7505.962470187833, 7167.3549380556, 7210.0, 7414.0, 7446.180920098676, 7468.551886886804, 6263.686815659108, 6283.868903597397, 7325.120985481776, 7339.119305683352, 7371.41028717712, 7466.887996679946, 7467.253274672489, 7474.402047836052, 7491.43814213947, 7506.924930750841, 7035.155781306276, 7291.708331666886, 7295.489315748059, 7297.16082650502, 7321.890171647536], "unit": "score", "name": "prototype.html", "value": 5356.747918510512}, {"lowerIsBetter": false, "replicates": [698.5773606967784, 759.6847308367028, 763.4426868386078, 763.7479631721533, 778.6690656470998, 15158.696826063471, 15335.079895206267, 15385.461508847193, 15412.768808467868, 15432.07407555546, 15950.76073858893, 16170.595735106628, 16173.919130404362, 16176.35294588215, 16267.267972941216, 758.7496126278315, 902.6254104546605, 929.907009299068, 935.2798345274135, 936.9599744283839, 898.2993265253081, 902.6795487601905, 906.4425378392307, 937.0208132501518, 940.2759874896326, 945.664289177339, 953.9904600953971, 972.8540718892152, 988.214369576185, 990.7671697151163, 939.741571067955, 939.9342046056779, 943.4669411782321, 985.6599473181741, 986.2898712926717, 696.9721211151548, 700.1073631120362, 701.4598758955626, 713.425692317684, 729.3727394440776, 15383.538493845203, 15499.457518986894, 15716.135612541306, 15742.842571574367, 15780.0, 12606.243625382507, 12620.368981550977, 12734.681632959158, 12827.615171544869, 12900.0, 9652.372595781251, 9743.269254805848, 9745.463999480025, 9795.412275263507, 9798.216142708567, 2923.6199294091844, 3491.94762078569, 3495.3009398120225, 3496.73774466916, 3506.1234691327168, 82752.93117672046, 84164.31671366538, 85454.0, 85564.57217713934, 85714.0, 7803.180666029985, 9150.86273705895, 9337.019612940543, 9366.859497107549, 9410.764730881783, 20947.8952605236, 21198.0, 21478.57042859134, 21934.0, 21938.0, 7327.230640782641, 7344.559326440431, 7416.184219735825, 7546.094468663796, 7627.656755445907, 3996.541262439247, 4009.298372784751, 4027.516697996259, 4029.9798501007895, 4032.737872038308, 3595.26297109092, 3602.1895073608753, 3603.7837729736298, 3665.7983810890123, 3670.284294562535, 574.3022227992925, 651.7295322441133, 656.186328952096, 656.1994366872408, 663.9701213445406, 488.68235646829845, 507.42660793304066, 541.2233445006428, 591.5770224289654, 623.0467384901109, 7201.783946481614, 7368.963155184297, 7598.430117741192, 8273.420860539705, 8394.706185283485, 507.2391412880679, 510.75228514170595, 620.3331418724889, 625.1529177963794, 634.5621521150391, 3631.4371272452813, 3685.2445248724484, 3719.479272901796, 3807.9428808567895, 3932.783696896641, 95201.04798952061, 95463.04536954542, 95815.0, 97476.53785193228, 97987.0, 63836.0, 79930.40139197299, 81037.0, 81352.77970830443, 83108.337833243, 72073.27926720666, 72267.2773272271, 74056.62971685214, 74176.0, 74945.25054749382, 7100.893486597808, 7129.597458678671, 7133.678984445816, 7193.633209690142, 7320.084989376328, 48492.272615910086, 49437.0, 49704.0, 49711.00577988492, 49829.750851246965, 68833.0, 70613.0, 72560.0, 72817.907731383, 74008.62995684987, 10058.899411006088, 10112.342697724624, 10119.898801011896, 10160.23798215122, 10625.149988001096, 9566.330356874952, 10791.082757965662, 11052.668419947415, 11095.778084438427, 11216.719582010188, 10322.587096516056, 10340.327878687862, 10449.634262800766, 10478.266521343432, 10857.294275872044, 10292.022257885488, 10309.688719051283, 10527.526261318411, 10655.57377704883, 10723.142148627934, 10226.795464090825, 10278.280520363503, 10301.536430860479, 10319.587216511256, 10368.637097701545, 8766.517841518522, 8957.865632015395, 8989.685361012333, 9169.128932751379, 9229.861552076858, 8872.822543549222, 8973.820523589622, 9010.459372437675, 9027.687960761254, 9052.004279529116], "unit": "score", "name": "yui.html", "value": 6813.899663605056}], "name": "dromaeo_css", "value": 7551.96309227471}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 119.0, 168.0, 168.0, 127.0, 127.0, 114.0, 116.0, 124.0, 167.0], "unit": "score", "name": "ai-astar", "value": 134.5}, {"lowerIsBetter": true, "replicates": [152.0, 123.0, 143.0, 192.0, 151.0, 141.0, 124.0, 153.0, 149.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [186.0, 221.0, 196.0, 204.0, 215.0, 220.0, 200.0, 281.0, 183.0, 270.0], "unit": "score", "name": "audio-dft", "value": 217.6}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 75.0, 114.0, 74.0, 79.0, 85.0, 87.0, 153.0, 56.0], "unit": "score", "name": "audio-fft", "value": 86.1}, {"lowerIsBetter": true, "replicates": [86.0, 64.0, 109.0, 60.0, 65.0, 74.0, 145.0, 124.0, 117.0, 158.0], "unit": "score", "name": "audio-oscillator", "value": 100.2}, {"lowerIsBetter": true, "replicates": [89.0, 101.0, 133.0, 87.0, 89.0, 85.0, 89.0, 87.0, 90.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.6}, {"lowerIsBetter": true, "replicates": [149.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 120.0, 143.0, 99.0], "unit": "score", "name": "imaging-darkroom", "value": 108.1}, {"lowerIsBetter": true, "replicates": [90.0, 97.0, 91.0, 99.0, 94.0, 89.0, 90.0, 96.0, 90.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 92.7}, {"lowerIsBetter": true, "replicates": [57.0, 62.0, 67.0, 86.0, 87.0, 82.0, 69.0, 60.0, 48.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 67.2}, {"lowerIsBetter": true, "replicates": [67.0, 73.0, 105.0, 76.0, 79.0, 76.0, 73.0, 73.0, 88.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 77.0}, {"lowerIsBetter": true, "replicates": [92.0, 112.0, 118.0, 113.0, 84.0, 83.0, 97.0, 72.0, 104.0, 95.0], "unit": "score", "name": "stanford-crypto-aes", "value": 97.0}, {"lowerIsBetter": true, "replicates": [133.0, 133.0, 136.0, 120.0, 149.0, 160.0, 136.0, 130.0, 123.0, 138.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 135.8}, {"lowerIsBetter": true, "replicates": [131.0, 136.0, 138.0, 142.0, 139.0, 130.0, 155.0, 185.0, 177.0, 177.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.0}, {"lowerIsBetter": true, "replicates": [67.0, 74.0, 100.0, 91.0, 58.0, 57.0, 90.0, 101.0, 97.0, 99.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 83.4}], "name": "kraken", "value": 1589.0000000000002}]} 00:18:12 INFO - Return code: 0 00:18:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:18:12 ERROR - # TBPL SUCCESS # 00:18:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:18:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:18:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:18:12 INFO - 2016-03-30 00:18:12.526 screenresolution[1687:11477] starting screenresolution argv=screenresolution get 00:18:12 INFO - 2016-03-30 00:18:12.529 screenresolution[1687:11477] Display 0: 1600x1200x32@60 00:18:12 INFO - 2016-03-30 00:18:12.535 screenresolution[1688:11480] starting screenresolution argv=screenresolution list 00:18:12 INFO - Available Modes on Display 0 00:18:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:18:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:18:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:18:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:18:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:18:12 INFO - Intel Iris: 00:18:12 INFO - Chipset Model: Intel Iris 00:18:12 INFO - Type: GPU 00:18:12 INFO - Bus: Built-In 00:18:12 INFO - VRAM (Dynamic, Max): 1536 MB 00:18:12 INFO - Vendor: Intel (0x8086) 00:18:12 INFO - Device ID: 0x0a2e 00:18:12 INFO - Revision ID: 0x0009 00:18:12 INFO - Displays: 00:18:12 INFO - Display: 00:18:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:18:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:18:12 INFO - Display Serial Number: 1600x1200 60 00:18:12 INFO - Main Display: Yes 00:18:12 INFO - Mirror: Off 00:18:12 INFO - Online: Yes 00:18:12 INFO - Rotation: Supported 00:18:12 INFO - Return code: 0 00:18:12 INFO - Running post-action listener: _resource_record_post_action 00:18:12 INFO - Running post-run listener: _resource_record_post_run 00:18:13 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 38690304; Write bytes: 713607168; Read time: 501; Write time: 2253 00:18:13 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398426624; Write bytes: 392202240; Read time: 30068; Write time: 751 00:18:13 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 36908544; Write bytes: 308215808; Read time: 482; Write time: 1463 00:18:13 INFO - Running post-run listener: _upload_blobber_files 00:18:13 INFO - Blob upload gear active. 00:18:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:18:13 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 00:18:13 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'] 00:18:13 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 00:18:14 INFO - (blobuploader) - INFO - Open directory for files ... 00:18:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:18:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:18:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:18:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:18:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:18:15 INFO - (blobuploader) - INFO - Done attempting. 00:18:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:18:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:18:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:18:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:18:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:18:16 INFO - (blobuploader) - INFO - Done attempting. 00:18:16 INFO - (blobuploader) - INFO - Iteration through files over. 00:18:16 INFO - Return code: 0 00:18:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:18:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:18:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42b80ca7e8c99cbd0824d0e1626ecb26442024503e6b71e28a7957bcac73f28534c29c3719b520034fcdb06062ae746e5394eb415d3baf8228095c7463708062", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f6cf457e52ce01e1403b1b0e83a2c98668adfe07a495ce452ec5a17276fde4227f90b5cfad60122fe1d4bfd7b588b3403c91d09640792dfc515d6b79638907a"} 00:18:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:18:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:18:16 INFO - Contents: 00:18:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42b80ca7e8c99cbd0824d0e1626ecb26442024503e6b71e28a7957bcac73f28534c29c3719b520034fcdb06062ae746e5394eb415d3baf8228095c7463708062", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f6cf457e52ce01e1403b1b0e83a2c98668adfe07a495ce452ec5a17276fde4227f90b5cfad60122fe1d4bfd7b588b3403c91d09640792dfc515d6b79638907a"} 00:18:16 INFO - Running post-run listener: copy_logs_to_upload_dir 00:18:16 INFO - Copying logs to upload dir... 00:18:16 INFO - mkdir: /builds/slave/test/build/upload/logs 00:18:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1327.387283 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 7 secs) (at 2016-03-30 00:18:16.378918) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 00:18:16.382085) ========= 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.BlbliYY556/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.PzjUd0tVlW/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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/42b80ca7e8c99cbd0824d0e1626ecb26442024503e6b71e28a7957bcac73f28534c29c3719b520034fcdb06062ae746e5394eb415d3baf8228095c7463708062", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f6cf457e52ce01e1403b1b0e83a2c98668adfe07a495ce452ec5a17276fde4227f90b5cfad60122fe1d4bfd7b588b3403c91d09640792dfc515d6b79638907a"} build_url:https://queue.taskcluster.net/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/ekDHoshMTl2KTImpG9Z-uw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42b80ca7e8c99cbd0824d0e1626ecb26442024503e6b71e28a7957bcac73f28534c29c3719b520034fcdb06062ae746e5394eb415d3baf8228095c7463708062", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f6cf457e52ce01e1403b1b0e83a2c98668adfe07a495ce452ec5a17276fde4227f90b5cfad60122fe1d4bfd7b588b3403c91d09640792dfc515d6b79638907a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 00:18:16.409619) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 00:18:16.409948) ========= 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.BlbliYY556/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.PzjUd0tVlW/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005038 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 00:18:16.458876) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 00:18:16.459182) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 00:18:16.459576) ========= ========= Total master_lag: 0.45 =========