builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0013 starttime: 1454226930.37 results: success (0) buildid: 20160130230825 builduid: cb260980ee30480ea1f54321bd8a18aa revision: be27e36ce427df475b3ff827d8c0258c1c34c5b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.368518) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.368959) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.369267) ========= 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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005444 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.392178) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.392444) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.408642) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.408908) ========= 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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005518 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.456209) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.456464) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.456784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.457052) ========= 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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-01-30 23:55:30-- 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% 16.4M=0.001s 2016-01-30 23:55:30 (16.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.221118 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.692928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.693228) ========= 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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.026339 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.741969) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:30.742272) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev be27e36ce427df475b3ff827d8c0258c1c34c5b5 --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 be27e36ce427df475b3ff827d8c0258c1c34c5b5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9yJjO7jFmq/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.JlRhGtj3i1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-01-30 23:55:30,808 truncating revision to first 12 chars 2016-01-30 23:55:30,808 Setting DEBUG logging. 2016-01-30 23:55:30,808 attempt 1/10 2016-01-30 23:55:30,808 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/be27e36ce427?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-30 23:55:31,498 unpacking tar archive at: fx-team-be27e36ce427/testing/mozharness/ program finished with exit code 0 elapsedTime=0.929419 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:31.687998) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:31.688331) ========= echo be27e36ce427df475b3ff827d8c0258c1c34c5b5 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'be27e36ce427df475b3ff827d8c0258c1c34c5b5'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9yJjO7jFmq/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.JlRhGtj3i1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 be27e36ce427df475b3ff827d8c0258c1c34c5b5 program finished with exit code 0 elapsedTime=0.005279 script_repo_revision: 'be27e36ce427df475b3ff827d8c0258c1c34c5b5' ========= master_lag: 0.44 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:32.136141) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:32.136472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-30 23:55:32.161824) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-30 23:55:32.162163) ========= /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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:55:32 INFO - MultiFileLogger online at 20160130 23:55:32 in /builds/slave/test 23:55:32 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:55:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:55:32 INFO - {'append_to_log': False, 23:55:32 INFO - 'base_work_dir': '/builds/slave/test', 23:55:32 INFO - 'blob_upload_branch': 'Fx-Team', 23:55:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:55:32 INFO - 'branch': 'Fx-Team', 23:55:32 INFO - 'buildbot_json_path': 'buildprops.json', 23:55:32 INFO - 'config_files': ('talos/mac_config.py',), 23:55:32 INFO - 'default_actions': ('clobber', 23:55:32 INFO - 'read-buildbot-config', 23:55:32 INFO - 'download-and-extract', 23:55:32 INFO - 'populate-webroot', 23:55:32 INFO - 'create-virtualenv', 23:55:32 INFO - 'install', 23:55:32 INFO - 'run-tests'), 23:55:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:55:32 INFO - 'download_minidump_stackwalk': True, 23:55:32 INFO - 'download_symbols': 'ondemand', 23:55:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:55:32 INFO - 'tooltool.py': '/tools/tooltool.py', 23:55:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:55:32 INFO - '/tools/misc-python/virtualenv.py')}, 23:55:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:55:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:55:32 INFO - 'installer_path': 'installer.exe', 23:55:32 INFO - 'log_level': 'info', 23:55:32 INFO - 'log_name': 'talos', 23:55:32 INFO - 'log_to_console': True, 23:55:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:55:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:55:32 INFO - 'opt_config_files': (), 23:55:32 INFO - 'pip_index': False, 23:55:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:55:32 INFO - 'cmd': ('bash', 23:55:32 INFO - '-c', 23:55:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:55:32 INFO - 'enabled': True, 23:55:32 INFO - 'halt_on_failure': False, 23:55:32 INFO - 'name': 'check_screen_resolution'},), 23:55:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:55:32 INFO - 'cmd': ('bash', 23:55:32 INFO - '-c', 23:55:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:55:32 INFO - 'enabled': True, 23:55:32 INFO - 'halt_on_failure': False, 23:55:32 INFO - 'name': 'check_screen_resolution'},), 23:55:32 INFO - 'run_cmd_checks_enabled': True, 23:55:32 INFO - 'sps_profile': False, 23:55:32 INFO - 'sps_profile_interval': 0, 23:55:32 INFO - 'suite': 'dromaeojs-e10s', 23:55:32 INFO - 'system_bits': '32', 23:55:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:55:32 INFO - 'title': 't-yosemite-r7-0013', 23:55:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:55:32 INFO - 'use_talos_json': True, 23:55:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:55:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:55:32 INFO - 'work_dir': 'build'} 23:55:32 INFO - ##### 23:55:32 INFO - ##### Running clobber step. 23:55:32 INFO - ##### 23:55:32 INFO - Running pre-action listener: _resource_record_pre_action 23:55:32 INFO - Running main action method: clobber 23:55:32 INFO - rmtree: /builds/slave/test/build 23:55:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:55:34 INFO - Running post-action listener: _resource_record_post_action 23:55:34 INFO - ##### 23:55:34 INFO - ##### Running read-buildbot-config step. 23:55:34 INFO - ##### 23:55:34 INFO - Running pre-action listener: _resource_record_pre_action 23:55:34 INFO - Running main action method: read_buildbot_config 23:55:34 INFO - Using buildbot properties: 23:55:34 INFO - { 23:55:34 INFO - "project": "", 23:55:34 INFO - "product": "firefox", 23:55:34 INFO - "script_repo_revision": "production", 23:55:34 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 23:55:34 INFO - "repository": "", 23:55:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 23:55:34 INFO - "buildid": "20160130230825", 23:55:34 INFO - "pgo_build": "False", 23:55:34 INFO - "basedir": "/builds/slave/test", 23:55:34 INFO - "buildnumber": 283, 23:55:34 INFO - "slavename": "t-yosemite-r7-0013", 23:55:34 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 23:55:34 INFO - "platform": "yosemite_r7", 23:55:34 INFO - "scheduler": "tests-fx-team-macosx64-talos", 23:55:34 INFO - "branch": "fx-team", 23:55:34 INFO - "repo_path": "integration/fx-team", 23:55:34 INFO - "revision": "be27e36ce427df475b3ff827d8c0258c1c34c5b5", 23:55:34 INFO - "stage_platform": "macosx64", 23:55:34 INFO - "builduid": "cb260980ee30480ea1f54321bd8a18aa", 23:55:34 INFO - "slavebuilddir": "test" 23:55:34 INFO - } 23:55:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 23:55:34 INFO - Running post-action listener: _resource_record_post_action 23:55:34 INFO - ##### 23:55:34 INFO - ##### Running download-and-extract step. 23:55:34 INFO - ##### 23:55:34 INFO - Running pre-action listener: _resource_record_pre_action 23:55:34 INFO - Running main action method: download_and_extract 23:55:34 INFO - mkdir: /builds/slave/test/build/tests 23:55: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:55:34 INFO - https://queue.taskcluster.net/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:55:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/test_packages.json 23:55:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/test_packages.json 23:55:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 23:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 23:55:36 INFO - Downloaded 1277 bytes. 23:55:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 23:55:36 INFO - Using the following test package requirements: 23:55:36 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 23:55:36 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:55:36 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 23:55:36 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:55:36 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 23:55:36 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:55:36 INFO - u'jsshell-mac.zip'], 23:55:36 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:55:36 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 23:55:36 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 23:55:36 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:55:36 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 23:55:36 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:55:36 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 23:55:36 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:55:36 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 23:55:36 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 23:55:36 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 23:55:36 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 23:55:36 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:55:36 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:55:36 INFO - https://queue.taskcluster.net/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:55:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 23:55:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 23:55:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 23:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:55:38 INFO - Downloaded 17114302 bytes. 23:55:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:55:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 23:55:41 INFO - Return code: 0 23:55:41 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 23:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:41 INFO - https://queue.taskcluster.net/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:55:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 23:55:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 23:55:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 23:55:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:55:42 INFO - Downloaded 17114302 bytes. 23:55:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:55:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 23:55:46 INFO - Return code: 0 23:55:46 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:55:46 INFO - https://queue.taskcluster.net/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:55:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 23:55:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 23:55:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 23:55:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 23:55:47 INFO - Downloaded 10706582 bytes. 23:55:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:55:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 23:55:47 INFO - Return code: 0 23:55: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:55:47 INFO - https://queue.taskcluster.net/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 23:55:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 23:55:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 23:55:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 23:55:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 23:55:50 INFO - Downloaded 111112469 bytes. 23:55:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 23:55:50 INFO - mkdir: /builds/slave/test/properties 23:55:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:55:50 INFO - Writing to file /builds/slave/test/properties/build_url 23:55:50 INFO - Contents: 23:55:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 23:55:50 INFO - Running post-action listener: _resource_record_post_action 23:55:50 INFO - Running post-action listener: set_extra_try_arguments 23:55:50 INFO - ##### 23:55:50 INFO - ##### Running populate-webroot step. 23:55:50 INFO - ##### 23:55:50 INFO - Running pre-action listener: _resource_record_pre_action 23:55:50 INFO - Running main action method: populate_webroot 23:55:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:55:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:55:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:55:50 INFO - '--tppagecycles', 23:55:50 INFO - '7'], 23:55:50 INFO - 'tests': ['tsvgm']}}, 23:55:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:55:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:55:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:55:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 23:55:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:55:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:55:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:55:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:50 INFO - 'talos_options': ['--e10s'], 23:55:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:55:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:50 INFO - 'tests': ['damp', 'tps']}, 23:55:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:50 INFO - 'talos_options': ['--e10s'], 23:55:50 INFO - 'tests': ['damp', 'tps']}, 23:55:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:55:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:55:50 INFO - 'other': {'tests': ['a11yr', 23:55:50 INFO - 'ts_paint', 23:55:50 INFO - 'tpaint', 23:55:50 INFO - 'sessionrestore', 23:55:50 INFO - 'sessionrestore_no_auto_restore']}, 23:55:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:55:50 INFO - 'tests': ['a11yr', 23:55:50 INFO - 'ts_paint', 23:55:50 INFO - 'tpaint', 23:55:50 INFO - 'sessionrestore', 23:55:50 INFO - 'sessionrestore_no_auto_restore']}, 23:55:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:55:50 INFO - 'tests': ['a11yr', 23:55:50 INFO - 'ts_paint', 23:55:50 INFO - 'tpaint', 23:55:50 INFO - 'sessionrestore', 23:55:50 INFO - 'sessionrestore_no_auto_restore']}, 23:55:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:55:50 INFO - 'tests': ['a11yr', 23:55:50 INFO - 'ts_paint', 23:55:50 INFO - 'tpaint', 23:55:50 INFO - 'sessionrestore', 23:55:50 INFO - 'sessionrestore_no_auto_restore']}, 23:55:50 INFO - 'other_l64': {'tests': ['a11yr', 23:55:50 INFO - 'ts_paint', 23:55:50 INFO - 'tpaint', 23:55:50 INFO - 'sessionrestore', 23:55:50 INFO - 'sessionrestore_no_auto_restore']}, 23:55:50 INFO - 'other_nol64': {'tests': ['a11yr', 23:55:50 INFO - 'ts_paint', 23:55:50 INFO - 'tpaint', 23:55:50 INFO - 'sessionrestore', 23:55:50 INFO - 'sessionrestore_no_auto_restore']}, 23:55:50 INFO - 'svgr': {'tests': ['tsvgx', 23:55:50 INFO - 'tsvgr_opacity', 23:55:50 INFO - 'tart', 23:55:50 INFO - 'tscrollx', 23:55:50 INFO - 'cart']}, 23:55:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:55:50 INFO - 'tests': ['tsvgx', 23:55:50 INFO - 'tsvgr_opacity', 23:55:50 INFO - 'tart', 23:55:50 INFO - 'tscrollx', 23:55:50 INFO - 'cart']}, 23:55:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:50 INFO - 'tests': ['tp5o']}, 23:55:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:50 INFO - 'talos_options': ['--e10s'], 23:55:50 INFO - 'tests': ['tp5o']}, 23:55:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:50 INFO - 'talos_options': ['--xperf_path', 23:55:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:55:50 INFO - 'tests': ['tp5n']}, 23:55:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:50 INFO - 'talos_options': ['--e10s', 23:55:50 INFO - '--xperf_path', 23:55:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:55:50 INFO - 'tests': ['tp5n']}}, 23:55:50 INFO - 'talos.zip': {'path': '', 23:55:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:55:50 INFO - Running post-action listener: _resource_record_post_action 23:55:50 INFO - ##### 23:55:50 INFO - ##### Running create-virtualenv step. 23:55:50 INFO - ##### 23:55:50 INFO - Running pre-action listener: _resource_record_pre_action 23:55:50 INFO - Running main action method: create_virtualenv 23:55:50 INFO - Creating virtualenv /builds/slave/test/build/venv 23:55:50 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:55:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:55:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:55:50 INFO - Using real prefix '/tools/python27' 23:55:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:55:51 INFO - Installing distribute.............................................................................................................................................................................................done. 23:55:54 INFO - Installing pip.................done. 23:55:54 INFO - Return code: 0 23:55:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:55:54 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:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:54 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:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:54 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 0x10401da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb459587ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ec2d30>, '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 0x103d25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb8b20>, '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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:55:54 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:55:54 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:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yJjO7jFmq/Render', 23:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:55:54 INFO - 'HOME': '/Users/cltbld', 23:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:55:54 INFO - 'LOGNAME': 'cltbld', 23:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:54 INFO - 'MOZ_NO_REMOTE': '1', 23:55:54 INFO - 'NO_EM_RESTART': '1', 23:55:54 INFO - 'PAGER': '/bin/cat', 23:55:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:54 INFO - 'PWD': '/builds/slave/test', 23:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:55:54 INFO - 'SHELL': '/bin/bash', 23:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JlRhGtj3i1/Listeners', 23:55:54 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 23:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:55:54 INFO - 'USER': 'cltbld', 23:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:54 INFO - 'XPC_FLAGS': '0x0', 23:55:54 INFO - 'XPC_SERVICE_NAME': '0', 23:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:54 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:55:54 INFO - Cleaning up... 23:55:54 INFO - Return code: 0 23:55:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:55:54 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:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:54 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:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:54 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 0x10401da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb459587ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ec2d30>, '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 0x103d25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb8b20>, '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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:55:54 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:55:54 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:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yJjO7jFmq/Render', 23:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:55:54 INFO - 'HOME': '/Users/cltbld', 23:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:55:54 INFO - 'LOGNAME': 'cltbld', 23:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:54 INFO - 'MOZ_NO_REMOTE': '1', 23:55:54 INFO - 'NO_EM_RESTART': '1', 23:55:54 INFO - 'PAGER': '/bin/cat', 23:55:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:54 INFO - 'PWD': '/builds/slave/test', 23:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:55:54 INFO - 'SHELL': '/bin/bash', 23:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JlRhGtj3i1/Listeners', 23:55:54 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 23:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:55:54 INFO - 'USER': 'cltbld', 23:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:54 INFO - 'XPC_FLAGS': '0x0', 23:55:54 INFO - 'XPC_SERVICE_NAME': '0', 23:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:55 INFO - Downloading/unpacking psutil>=0.7.1 23:55:55 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:55:55 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:55:55 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:55:55 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:55:55 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:55:55 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:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:55:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:55:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:55:58 INFO - Installing collected packages: psutil 23:55:58 INFO - Running setup.py install for psutil 23:55:58 INFO - building 'psutil._psutil_osx' extension 23:55:58 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:55:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 23:55:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 23:55:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 23:55:59 INFO - building 'psutil._psutil_posix' extension 23:55:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 23:55:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:55:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:55:59 INFO - ^ 23:55:59 INFO - 1 warning generated. 23:55:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 23:55:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:55:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:55:59 INFO - Successfully installed psutil 23:55:59 INFO - Cleaning up... 23:55:59 INFO - Return code: 0 23:55:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10401da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb459587ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ec2d30>, '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 0x103d25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb8b20>, '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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:55:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yJjO7jFmq/Render', 23:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:55:59 INFO - 'HOME': '/Users/cltbld', 23:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:55:59 INFO - 'LOGNAME': 'cltbld', 23:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:59 INFO - 'MOZ_NO_REMOTE': '1', 23:55:59 INFO - 'NO_EM_RESTART': '1', 23:55:59 INFO - 'PAGER': '/bin/cat', 23:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:59 INFO - 'PWD': '/builds/slave/test', 23:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:55:59 INFO - 'SHELL': '/bin/bash', 23:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JlRhGtj3i1/Listeners', 23:55:59 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 23:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:55:59 INFO - 'USER': 'cltbld', 23:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:59 INFO - 'XPC_FLAGS': '0x0', 23:55:59 INFO - 'XPC_SERVICE_NAME': '0', 23:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:56: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:56: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:56: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:56: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:56: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:56: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:56:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:56:02 INFO - Installing collected packages: mozsystemmonitor 23:56:02 INFO - Running setup.py install for mozsystemmonitor 23:56:02 INFO - Successfully installed mozsystemmonitor 23:56:02 INFO - Cleaning up... 23:56:02 INFO - Return code: 0 23:56:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10401da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb459587ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ec2d30>, '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 0x103d25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb8b20>, '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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:56:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:56:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yJjO7jFmq/Render', 23:56:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:56:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:56:02 INFO - 'HOME': '/Users/cltbld', 23:56:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:56:02 INFO - 'LOGNAME': 'cltbld', 23:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:02 INFO - 'MOZ_NO_REMOTE': '1', 23:56:02 INFO - 'NO_EM_RESTART': '1', 23:56:02 INFO - 'PAGER': '/bin/cat', 23:56:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:02 INFO - 'PWD': '/builds/slave/test', 23:56:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:56:02 INFO - 'SHELL': '/bin/bash', 23:56:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JlRhGtj3i1/Listeners', 23:56:02 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 23:56:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:56:02 INFO - 'USER': 'cltbld', 23:56:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:56:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:02 INFO - 'XPC_FLAGS': '0x0', 23:56:02 INFO - 'XPC_SERVICE_NAME': '0', 23:56:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:02 INFO - Downloading/unpacking blobuploader==1.2.4 23:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:04 INFO - Downloading blobuploader-1.2.4.tar.gz 23:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:56:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:56:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:06 INFO - Downloading docopt-0.6.1.tar.gz 23:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:56:06 INFO - Installing collected packages: blobuploader, requests, docopt 23:56:06 INFO - Running setup.py install for blobuploader 23:56:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:56:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:56:06 INFO - Running setup.py install for requests 23:56:06 INFO - Running setup.py install for docopt 23:56:06 INFO - Successfully installed blobuploader requests docopt 23:56:06 INFO - Cleaning up... 23:56:07 INFO - Return code: 0 23:56:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10401da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb459587ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ec2d30>, '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 0x103d25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb8b20>, '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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:56:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:56:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yJjO7jFmq/Render', 23:56:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:56:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:56:07 INFO - 'HOME': '/Users/cltbld', 23:56:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:56:07 INFO - 'LOGNAME': 'cltbld', 23:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:07 INFO - 'MOZ_NO_REMOTE': '1', 23:56:07 INFO - 'NO_EM_RESTART': '1', 23:56:07 INFO - 'PAGER': '/bin/cat', 23:56:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:07 INFO - 'PWD': '/builds/slave/test', 23:56:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:56:07 INFO - 'SHELL': '/bin/bash', 23:56:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JlRhGtj3i1/Listeners', 23:56:07 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 23:56:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:56:07 INFO - 'USER': 'cltbld', 23:56:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:56:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:07 INFO - 'XPC_FLAGS': '0x0', 23:56:07 INFO - 'XPC_SERVICE_NAME': '0', 23:56:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:56:07 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-wHzriL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:56:07 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-2CRXdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:56:07 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-l6nr8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:56:07 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ltWDgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:56:07 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-lt4kgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:56:07 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-XTkT3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:56:07 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-btKAXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:56:08 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-8tN_xN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:56:08 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-NnkhhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:56:08 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-mZJojs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:56:08 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-HvEmvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:56:08 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-gaP_9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:56:08 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-qLu7BN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:56:08 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-hw0bIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:56:08 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-3HWQXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:56:08 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Kx8YEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:56:08 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-G6lSnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:56:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:56:09 INFO - Running setup.py install for manifestparser 23:56:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:56:09 INFO - Running setup.py install for mozcrash 23:56:09 INFO - Running setup.py install for mozdebug 23:56:09 INFO - Running setup.py install for mozdevice 23:56:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:56:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:56:09 INFO - Running setup.py install for mozfile 23:56:09 INFO - Running setup.py install for mozhttpd 23:56:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:56:09 INFO - Running setup.py install for mozinfo 23:56:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:56:10 INFO - Running setup.py install for mozInstall 23:56:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:56:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:56:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:56:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:56:10 INFO - Running setup.py install for mozleak 23:56:10 INFO - Running setup.py install for mozlog 23:56:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:56:10 INFO - Running setup.py install for moznetwork 23:56:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:56:10 INFO - Running setup.py install for mozprocess 23:56:10 INFO - Running setup.py install for mozprofile 23:56:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:56:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:56:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:56:11 INFO - Running setup.py install for mozrunner 23:56:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:56:11 INFO - Running setup.py install for mozscreenshot 23:56:11 INFO - Running setup.py install for moztest 23:56:11 INFO - Running setup.py install for mozversion 23:56:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:56:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:56:11 INFO - Cleaning up... 23:56:11 INFO - Return code: 0 23:56:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:56:11 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:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:11 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 0x10401da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb459587ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ec2d30>, '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 0x103d25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb8b20>, '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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:56:11 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:56:11 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:56:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yJjO7jFmq/Render', 23:56:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:56:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:56:11 INFO - 'HOME': '/Users/cltbld', 23:56:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:56:11 INFO - 'LOGNAME': 'cltbld', 23:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:11 INFO - 'MOZ_NO_REMOTE': '1', 23:56:11 INFO - 'NO_EM_RESTART': '1', 23:56:11 INFO - 'PAGER': '/bin/cat', 23:56:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:11 INFO - 'PWD': '/builds/slave/test', 23:56:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:56:11 INFO - 'SHELL': '/bin/bash', 23:56:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JlRhGtj3i1/Listeners', 23:56:11 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 23:56:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:56:11 INFO - 'USER': 'cltbld', 23:56:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:56:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:11 INFO - 'XPC_FLAGS': '0x0', 23:56:11 INFO - 'XPC_SERVICE_NAME': '0', 23:56:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:56:11 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-VefFuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:56:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-1Xefjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:56:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ci4vle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:56:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-DKE97z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:56:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Huxd58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:56:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-6Xn1nE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:56:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-612yJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:56:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-rvv0dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:56:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-vlRcUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:56:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-mljWzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:56:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-pSrQQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:56:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-h2PADN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:56:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-RD5cDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:56:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-5kkX5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:56:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-kd_hk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:56:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-nHhiem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:56:13 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:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:56:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-AY9V7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:56:13 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:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:56:13 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:56:13 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:56:13 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:56:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:56:13 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:56:13 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:56:13 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:56:13 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:56:13 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:56:13 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:56:15 INFO - Downloading blessings-1.6.tar.gz 23:56:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:56:16 INFO - Installing collected packages: blessings 23:56:16 INFO - Running setup.py install for blessings 23:56:16 INFO - Successfully installed blessings 23:56:16 INFO - Cleaning up... 23:56:16 INFO - Return code: 0 23:56:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:56:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:56:16 INFO - Reading from file tmpfile_stdout 23:56:16 INFO - Current package versions: 23:56:16 INFO - blessings == 1.6 23:56:16 INFO - blobuploader == 1.2.4 23:56:16 INFO - docopt == 0.6.1 23:56:16 INFO - manifestparser == 1.1 23:56:16 INFO - mozInstall == 1.12 23:56:16 INFO - mozcrash == 0.16 23:56:16 INFO - mozdebug == 0.1 23:56:16 INFO - mozdevice == 0.48 23:56:16 INFO - mozfile == 1.2 23:56:16 INFO - mozhttpd == 0.7 23:56:16 INFO - mozinfo == 0.9 23:56:16 INFO - mozleak == 0.1 23:56:16 INFO - mozlog == 3.1 23:56:16 INFO - moznetwork == 0.27 23:56:16 INFO - mozprocess == 0.22 23:56:16 INFO - mozprofile == 0.28 23:56:16 INFO - mozrunner == 6.11 23:56:16 INFO - mozscreenshot == 0.1 23:56:16 INFO - mozsystemmonitor == 0.0 23:56:16 INFO - moztest == 0.7 23:56:16 INFO - mozversion == 1.4 23:56:16 INFO - psutil == 3.1.1 23:56:16 INFO - requests == 1.2.3 23:56:16 INFO - wsgiref == 0.1.2 23:56:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:56:16 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:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:16 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:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:16 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 0x10401da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb459587ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ec2d30>, '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 0x103d25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb8b20>, '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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:56:16 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:56:16 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:56:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yJjO7jFmq/Render', 23:56:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:56:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:56:16 INFO - 'HOME': '/Users/cltbld', 23:56:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:56:16 INFO - 'LOGNAME': 'cltbld', 23:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:16 INFO - 'MOZ_NO_REMOTE': '1', 23:56:16 INFO - 'NO_EM_RESTART': '1', 23:56:16 INFO - 'PAGER': '/bin/cat', 23:56:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:16 INFO - 'PWD': '/builds/slave/test', 23:56:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:56:16 INFO - 'SHELL': '/bin/bash', 23:56:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JlRhGtj3i1/Listeners', 23:56:16 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 23:56:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:56:16 INFO - 'USER': 'cltbld', 23:56:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:56:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:16 INFO - 'XPC_FLAGS': '0x0', 23:56:16 INFO - 'XPC_SERVICE_NAME': '0', 23:56:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:16 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:56:16 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:56:16 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:56:16 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:56:16 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:56:16 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:56:16 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:56:16 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:56:16 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:56:16 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:56:16 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:56:16 INFO - Cleaning up... 23:56:16 INFO - Return code: 0 23:56:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:56:16 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:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:16 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:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:16 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 0x10401da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb459587ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ec2d30>, '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 0x103d25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb8b20>, '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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:56:16 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:56:16 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:56:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yJjO7jFmq/Render', 23:56:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:56:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:56:16 INFO - 'HOME': '/Users/cltbld', 23:56:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:56:16 INFO - 'LOGNAME': 'cltbld', 23:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:16 INFO - 'MOZ_NO_REMOTE': '1', 23:56:16 INFO - 'NO_EM_RESTART': '1', 23:56:16 INFO - 'PAGER': '/bin/cat', 23:56:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:16 INFO - 'PWD': '/builds/slave/test', 23:56:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:56:16 INFO - 'SHELL': '/bin/bash', 23:56:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JlRhGtj3i1/Listeners', 23:56:16 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 23:56:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:56:16 INFO - 'USER': 'cltbld', 23:56:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:56:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:16 INFO - 'XPC_FLAGS': '0x0', 23:56:16 INFO - 'XPC_SERVICE_NAME': '0', 23:56:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:17 INFO - Downloading/unpacking jsonschema 23:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:56:19 INFO - Downloading/unpacking functools32 (from jsonschema) 23:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:19 INFO - Downloading functools32-3.2.3-2.tar.gz 23:56:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:56:19 INFO - warning: no files found matching '*.txt' 23:56:19 INFO - no previously-included directories found matching 'build' 23:56:19 INFO - no previously-included directories found matching 'dist' 23:56:19 INFO - no previously-included directories found matching '.git*' 23:56:19 INFO - Installing collected packages: jsonschema, functools32 23:56:19 INFO - Running setup.py install for functools32 23:56:20 INFO - warning: no files found matching '*.txt' 23:56:20 INFO - no previously-included directories found matching 'build' 23:56:20 INFO - no previously-included directories found matching 'dist' 23:56:20 INFO - no previously-included directories found matching '.git*' 23:56:20 INFO - Successfully installed jsonschema functools32 23:56:20 INFO - Cleaning up... 23:56:20 INFO - Return code: 0 23:56:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10401da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb459587ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ec2d30>, '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 0x103d25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb8b20>, '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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:56:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:56:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yJjO7jFmq/Render', 23:56:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:56:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:56:20 INFO - 'HOME': '/Users/cltbld', 23:56:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:56:20 INFO - 'LOGNAME': 'cltbld', 23:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:20 INFO - 'MOZ_NO_REMOTE': '1', 23:56:20 INFO - 'NO_EM_RESTART': '1', 23:56:20 INFO - 'PAGER': '/bin/cat', 23:56:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:20 INFO - 'PWD': '/builds/slave/test', 23:56:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:56:20 INFO - 'SHELL': '/bin/bash', 23:56:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JlRhGtj3i1/Listeners', 23:56:20 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 23:56:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:56:20 INFO - 'USER': 'cltbld', 23:56:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:56:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:20 INFO - 'XPC_FLAGS': '0x0', 23:56:20 INFO - 'XPC_SERVICE_NAME': '0', 23:56:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:20 INFO - Downloading/unpacking flake8 23:56:20 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:56:20 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:56:20 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:56:20 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:56:20 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:56:20 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:56:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:56:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:56:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:56:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:56:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:56:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:56:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:56:23 INFO - no previously-included directories found matching 'docs/_build' 23:56:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:56:23 INFO - Running setup.py install for pep8 23:56:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:56:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:56:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:56:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:56:24 INFO - no previously-included directories found matching 'docs/_build' 23:56:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:56:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:56:24 INFO - Cleaning up... 23:56:24 INFO - Return code: 0 23:56:24 INFO - Running post-action listener: _resource_record_post_action 23:56:24 INFO - Running post-action listener: _start_resource_monitoring 23:56:24 INFO - Starting resource monitoring. 23:56:24 INFO - ##### 23:56:24 INFO - ##### Running install step. 23:56:24 INFO - ##### 23:56:24 INFO - Running pre-action listener: _resource_record_pre_action 23:56:24 INFO - Running main action method: install 23:56:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:56:24 INFO - Reading from file tmpfile_stdout 23:56:24 INFO - Detecting whether we're running mozinstall >=1.0... 23:56:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:56:24 INFO - Reading from file tmpfile_stdout 23:56:24 INFO - Output received: 23:56:24 INFO - Usage: mozinstall [options] installer 23:56:24 INFO - Options: 23:56:24 INFO - -h, --help show this help message and exit 23:56:24 INFO - -d DEST, --destination=DEST 23:56:24 INFO - Directory to install application into. [default: 23:56:24 INFO - "/builds/slave/test"] 23:56:24 INFO - --app=APP Application being installed. [default: firefox] 23:56:24 INFO - mkdir: /builds/slave/test/build/application 23:56:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 23:56:58 INFO - Reading from file tmpfile_stdout 23:56:58 INFO - Output received: 23:56:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:56:58 INFO - Running post-action listener: _resource_record_post_action 23:56:58 INFO - ##### 23:56:58 INFO - ##### Running run-tests step. 23:56:58 INFO - ##### 23:56:58 INFO - Running pre-action listener: _resource_record_pre_action 23:56:58 INFO - Running main action method: run_tests 23:56:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:56:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:56:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:56:58 INFO - 2016-01-30 23:56:58.575 screenresolution[1666:14428] starting screenresolution argv=screenresolution get 23:56:58 INFO - 2016-01-30 23:56:58.578 screenresolution[1666:14428] Display 0: 1600x1200x32@60 23:56:58 INFO - 2016-01-30 23:56:58.584 screenresolution[1667:14430] starting screenresolution argv=screenresolution list 23:56:58 INFO - Available Modes on Display 0 23:56:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:56:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:56:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:56:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:56:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:56:58 INFO - Intel Iris: 23:56:58 INFO - Chipset Model: Intel Iris 23:56:58 INFO - Type: GPU 23:56:58 INFO - Bus: Built-In 23:56:58 INFO - VRAM (Dynamic, Max): 1536 MB 23:56:58 INFO - Vendor: Intel (0x8086) 23:56:58 INFO - Device ID: 0x0a2e 23:56:58 INFO - Revision ID: 0x0009 23:56:58 INFO - Displays: 23:56:58 INFO - Display: 23:56:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:56:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:56:58 INFO - Display Serial Number: 1600x1200 60 23:56:58 INFO - Main Display: Yes 23:56:58 INFO - Mirror: Off 23:56:58 INFO - Online: Yes 23:56:58 INFO - Rotation: Supported 23:56:58 INFO - Return code: 0 23:56:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:56:58 INFO - Python 2.7.3 23:56:58 INFO - Return code: 0 23:56:58 INFO - grabbing minidump binary from tooltool 23:56:58 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:58 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 0x103ec2d30>, '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 0x103d25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:56:58 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:56:58 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:56:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:56:58 INFO - Return code: 0 23:56:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:56:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:56:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:56:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:56:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:56:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:57:00 INFO - Return code: 0 23:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0013 --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:57:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yJjO7jFmq/Render', 23:57:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:57:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:57:00 INFO - 'HOME': '/Users/cltbld', 23:57:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:57:00 INFO - 'LOGNAME': 'cltbld', 23:57:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:57:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:00 INFO - 'MOZ_NO_REMOTE': '1', 23:57:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:57:00 INFO - 'NO_EM_RESTART': '1', 23:57:00 INFO - 'PAGER': '/bin/cat', 23:57:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:00 INFO - 'PWD': '/builds/slave/test', 23:57:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:57:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:57:00 INFO - 'SHELL': '/bin/bash', 23:57:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JlRhGtj3i1/Listeners', 23:57:00 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 23:57:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:57:00 INFO - 'USER': 'cltbld', 23:57:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:57:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:00 INFO - 'XPC_FLAGS': '0x0', 23:57:00 INFO - 'XPC_SERVICE_NAME': '0', 23:57:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:57:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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:57:00 INFO - mozversion application_buildid: 20160130230825 23:57:00 INFO - mozversion application_changeset: be27e36ce427df475b3ff827d8c0258c1c34c5b5 23:57:00 INFO - mozversion application_display_name: Nightly 23:57:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:57:00 INFO - mozversion application_name: Firefox 23:57:00 INFO - mozversion application_remotingname: firefox 23:57:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:57:00 INFO - mozversion application_vendor: Mozilla 23:57:00 INFO - mozversion application_version: 47.0a1 23:57:00 INFO - mozversion platform_buildid: 20160130230825 23:57:00 INFO - mozversion platform_changeset: OZ_SOURCE_CHANGESET 23:57:00 INFO - mozversion platform_version: 47.0a1 23:57:00 INFO - using testdate: 1454227020 23:57:00 INFO - actual date: 1454227020 23:57:00 INFO - starting webserver on 'localhost:49273' 23:57:00 INFO - SUITE-START | Running 2 tests 23:57:00 INFO - TEST-START | dromaeo_css 23:57:00 INFO - operating with platform_type : mac_ 23:57:00 INFO - Initialising browser for dromaeo_css test... 23:57:00 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpOxnJ7P/profile http://localhost:49273/getInfo.html) 23:57:01 INFO - PROCESS | 1685 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 23:57:03 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 23:57:03 INFO - PROCESS | 1685 | colorDepth:24 23:57:03 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 23:57:03 INFO - PROCESS | 1685 | __metrics 23:57:04 INFO - PROCESS | 1685 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:57:04 INFO - TEST-INFO | 1685: exit 0 23:57:04 INFO - Browser initialized. 23:57:04 INFO - Running cycle 1/1 for dromaeo_css test... 23:57:04 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpOxnJ7P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:57:16 INFO - PROCESS | 1689 | RSS: Main: 255102976 23:57:16 INFO - PROCESS | 1689 | 23:58:06 INFO - PROCESS | 1689 | 1454227086365 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:00:17 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 00:00:18 INFO - PROCESS | 1689 | RSS: Main: 268734464 00:00:18 INFO - PROCESS | 1689 | 00:03:20 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 00:03:21 INFO - PROCESS | 1689 | RSS: Main: 282189824 00:03:21 INFO - PROCESS | 1689 | 00:06:23 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 00:06:23 INFO - PROCESS | 1689 | RSS: Main: 283049984 00:06:23 INFO - PROCESS | 1689 | 00:09:25 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 00:09:25 INFO - PROCESS | 1689 | RSS: Main: 285941760 00:09:25 INFO - PROCESS | 1689 | 00:12:28 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 00:12:29 INFO - PROCESS | 1689 | RSS: Main: 286560256 00:12:29 INFO - PROCESS | 1689 | 00:15:31 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 00:15:31 INFO - PROCESS | 1689 | RSS: Main: 290820096 00:15:31 INFO - PROCESS | 1689 | 00:15:31 INFO - PROCESS | 1689 | __start_tp_report 00:15:31 INFO - PROCESS | 1689 | _x_x_mozilla_page_load 00:15:31 INFO - PROCESS | 1689 | _x_x_mozilla_page_load_details 00:15:31 INFO - PROCESS | 1689 | |i|pagename|runs| 00:15:31 INFO - PROCESS | 1689 | |0;dojo.html;3533.2050288685045;3550.9112272193192;3585.8744943926968;3606.8557257709695;3616.529851119354;5774.220480235167;5829;5839.153322768196;5870.031444811611;5885.176075349449;5472.589555783322;5648.74580643871;5783.710814459281;5788.594798364116;5803.071508558632;5173.715445650497;5206.427292997767;5223;5251.081060814361;5270.683758974455;4301.548337424572;5171.379434467869;5273.657212281209;5307.389650190239;5308.6814791112465;5297.152455607104;5326.067938110815;5336.039512887679;5338.439463856297;5354.9196762048605;5138.845834624967;5287.206918962148;5292.550133238679;5328.413874473805;5349.893002139955;5123.052235336475;5179.19722443022;5194.792208311663;5211.957608478319;5231.2937753403185;5536.667799931976;5597.132444471114;5666.016894087078;5726.055200891889;5786.768529258825;6145.586515101507;6226.452706069951;6229.53278504114;6257.812265632038;6266.373362663743;6160.938390616081;6213.161223234851;6229.408206220447;6232.563720539564;6245.812625621239;5865.120231965197;5939.940600593982;5952.7023648817385;5963.940360596382;5964.403559644001;6206.813795586139;6220.440160385497;6241.7191226394925;6242;6302.369763023753;6212.72042758077;6237.937620623827;6241.625502469867;6244.12582238487;6277.18396608438;6179.134921111048;6225.252969643671;6233.34549872266;6260.718267677966;6269.780557680459;6108.584917381041;6180.351063138306;6217.098520714471;6236.220472440945;6269.529785266123;6208.4722798562625;6213.099100630383;6227.314995350508;6229.3770622937345;6257.655828929362;4872.317875497433;4927;4930.235813448921;4935.679180853233;4952.158133117378;4360.106178233455;4390.473143222834;4412.294032954776;4415.735055896656;4475.753833539186;4631.957809492837;5741.942580574141;5783.248177736951;5801.622894511843;5833.766649334064;5878.353381128072;6148.739508400767;6166.753329866845;6243.8126856194385;6247.2815626202655;5689.004424225744;5751.654900705971;5778.219940308005;5788.421157884262;5836.124581312837;5385.676859388449;5401.135818269058;5405.729713514309;5409.810656626999;5457;6188.164597779422;6293.118963345044;6349.0476428536085;6373.936260637334;6387.265464471552;6175.59858609189;6206.193194884636;6207.751689932352;6221.564490485623;6231.844203894758;6330.335314792064;6335.714892829741;6337.271213810286;6349.206349206349;6380.649064301508;6122.908156377569;6146.186874872013;6168.0439531872635;6194.845128871814;6298.590591611531;6205.348438413902;6213.96893015532;6220.657863817352;6255.71849266775;6278.0896769967185;6157.815265542041;6220.191375121205;6224.875502489835;6236.220472440945;6237.376262373727;5932.525397968066;6045.274567051982;6052.273727152769;6110.40687992437;6204.224471941007;5972.402759723993;6038.305594856648;6076.088586712029;6090.908636370546;6108.389161083856;6114.327423983447;6186.969065154645;6196.47329976957;6210.844728881814;6233.844153896189;5953.315368732651;6048.153258543719;6065.211522502046;6100.823402702991;6109.327973922776 00:15:31 INFO - PROCESS | 1689 | |1;ext.html;452.76456242753767;464.24560089853986;482.9613630909528;514.1850167484537;588.2734822494219;30748.846255768716;36663;38425;38616.034599135004;38787;43111.78444107783;43583.564164358344;43906.56093439065;43944.3408348875;44011.55988440115;9708.902910970888;9856.310058295921;9970.35192712475;9973.202143828476;9993.150582200522;9802.803943921117;9900.603975840993;9964.701058968243;9965.850512242323;9989.450580218085;9937;10002.249831262649;10037.849432258521;10039;10041.04610062043;8583;9760.658376956773;9894.307398482073;10000.149987251092;10008.699739007805;9695.175910047654;9824.066713662261;9865.260105492045;9890.653827116017;9891;40202.39696404556;40373;40748.79625601853;40770.79614601908;40866.795666021775;3213.469777486712;3218.758593105503;3256.495243237302;3465.220325426759;3799.715021373408;28001.439971200463;28393.858030709922;28434.57348139759;28513.429731405464;28514.14457566276;2770.7921905857143;2806.4387122575363;2864.598956146141;2925.6196694429586;2998.7151220634005;422378.88810556056;422871;464271;465284;467389;41756.58243417527;57662;63701.681491593175;64252.678736606016;64618;70015;70177.64911175412;70760.2923970764;71108;71213.28786712067;16015.359385624677;16227.513174604781;16387.180640967905;16394.75407868859;16404.507864764077;12222.816657750142;12295.32375719344;12367.567135150226;12448.066395020409;12509.374531273399;20179.192832286542;20476.590468190552;20502.897485512476;20564.897175514026;20831;7676.501027433199;8939.418937769024;9234.584443700049;9249.815003699889;9253.213476854407;942.6465075596651;1038.787048655024;1051.3113910388709;1051.5530899367739;1143.9656810295705;26154.692265387035;28646.856765716453;29800.552991705143;29894.83150558291;30127.548086778716;903.2593273515786;984.9606015759433;1067.2315932528568;1097.3964319624174;1134.8921852424007;13183;14278.64352886474;15127.697446051017;15535.145566993699;15561;626012;738238;741065;741278.5872141317;742026;52340;58357.249282521596;60347.09479357726;60572;60587;1296.4895896280916;1433.4767809749367;1474.9262536873327;1479.2234077109604;1507.3744396075506;29147.979820706172;30147.19116852996;30464.543031854097;31768;32285.35429291448;45915;52565.47434525606;52762.73618631882;52977.7351113242;53243;503067;507882;509798;510394;512039;34309;44795.32807007832;44908.77545612251;45946.540534595566;46278;38235;44067.55932440763;44177.77911110424;44789.88025299263;45579.08841823211;31469.8426507866;39092.41361379639;39339.80330098446;39715;40216;37990.24019519649;38973.805130974164;39025.6097439022;39095.41356879592;39141.2171756569;37546.68586599456;38018.429723553614;38789.03027424337;38985.6101438982;39753.60246397499;33765.81819636301;34268.82865585656;34832.30335393227;34864.30271394608;35065.824670876485;24767.752322476543;25438.600876951205;25923.351916201493;25994.220173394828;27988.72011279861 00:15:31 INFO - PROCESS | 1689 | |2;jquery.html;352.16712474996643;362.5287126735244;365.45182226660006;368.5724559510968;368.8008475423272;15527.534173974798;18934.43196704101;19031.429057128273;19130.71303930442;19937.10283037263;11480.71298217545;12463.68840778981;16889.91555042223;19161.94609296488;19184.232630694754;3916.2950668879735;5178.223266510016;5417.26866872971;5431.701256430894;5432.619716619838;3377.257003459235;5039.420466646327;5939.079442686369;5941.079132734411;6056.576039677225;5708.08670612702;5885.617434866741;5897.056470964647;5942.741758131904;5985.34161242263;4565.589096981254;5864.061750119981;5865.941340586583;5895.263092113486;5930.199423077894;5470.5350045245805;5517.613767036309;5535.972320138414;5549.5837812163845;5552.08390615548;22573.54852902933;23894.880525597433;24143.913523891468;24312.39219019521;24501.50996980068;1834.7706536682915;2190.113004233288;2345.2260753951155;2380.345405013618;2578.4714133602565;9278.907210927871;10571.260011799177;12336;13507.392167352493;14373.85626143746;1725.413359457778;1749.4401791426749;1780.8931464112065;1793.4888556761261;1821.9908900455546;78350.60824695897;96348.51825740826;98926;99175.0082499173;100057;8893.199612034818;10984.670459886056;11190.440477976068;11300.773984520429;11353.978141967262;11887.821682674767;12868.099233053783;13309.600711978655;13533.661658458617;13553.25457099869;8367.581620918929;8407.327413806881;8474.491530508189;8486.321094312563;8529.57352132391;8478.74563763088;8482.830343393098;8508.915315747681;8571.22858942698;8575.528345940907;3981.980090099531;4189.287821070426;4189.4344263524035;4289.442372491556;4373.540778218305;1835.3484512997961;1852.3516769130697;1866.8039855815216;1891.9810801892081;1895.3934740882785;907.8728977943093;919.7562645898843;935.9017303183203;995.542050656706;1078.9784204316027;17420.640853141875;18784.154713037948;19198.232070717295;19206.231750730094;20321;936.784539555906;947.2185447006248;961.1541843177959;981.8183636027358;981.8478135888948;10680.305780124267;10886.945565272123;10939.12487001038;10953.068989135852;10959.890401095887;768022;770480;779103.7649036751;786205;793476;87137;110390;111761;113230;114526.4273678643;1121.315997241682;1139.1342579639368;1140.1391949078393;1156.7975604269388;1168.4391492083848;17819.46541603754;17858.821411785717;17879;17972.460826175236;17991.460256192335;45211.54788452073;46633;46828.76585617186;48894;49018.50981490282;61240.69379653073;63128.368716314086;63233.68383158055;63262.90494660516;63392.68303658452;7433.424041470419;7518.774436766906;7613.809654758454;7690.538567685733;7696.8460630788195;9267.814643706954;11450.770984580095;11705.590304339306;11919.3444360561;12046.337451439904;9710.6115755369;9946.35348702332;10174.745631359276;10274.589016439259;10378.584856605954;10029.99700029991;10149.64476243328;10345.482725863827;10568.313059651098;10629.36223826542;8717.433366831136;10105.545250463894;10467.408521900341;10619.893801061891;10744.355338679705;7556.433267504849;7663.27198916102;7726.3818894487185;7739.30346268816;7757.340626046624;9481.336306458481;10686.57253709843;10697.037266646039;10811.405372704578;10865.619703310345 00:15:31 INFO - PROCESS | 1689 | |3;mootools.html;1554.1529866222907;1562.2032763290717;1780.6794776940146;1884.3593178319368;1897.2885168061978;6932.965335173317;8073.636686349114;8795.648174073038;8892.599833007514;8966.641334346617;7462.21646727094;8559.743207703763;8662.393632445732;8731.694390696326;8751.431156974792;2126.4258650164447;2471.5921872890954;2492.277239600514;2495.5258500884775;2505.3110394641435;2494.4387512809562;2509.6611957385703;2509.7866681332016;2536.6575512305785;2545.898164073435;1945.5816999345138;2072.4715197624587;2435.7686019828175;2471.789897858684;2541.3519552514176;2258.9661155082686;2277.487565297811;2476.3932836455006;2485.3041148478455;2503.236512863576;2513.459606184679;2518.6851643544555;2519.5212909547313;2533.518631460035;2534.7845433138204;8821.955890220572;8831.823363532758;8853.911460885372;8903.37676362655;8911.643534258621;5272.736363181864;5420.810271640474;5437.32033495813;5437.755301011464;5446.482584154499;3602.2435288589168;3688.17016171362;3709.5548534176073;3735.122246272124;3739.775613463201;1053.8155822731069;1074.8065348237315;1079.1528650009705;1087.26066274933;1108.717277094344;11852;11999.580014699444;12018.338991355471;12041.518339266418;12078.637640870787;4859.222524396079;4864.951350486521;4929.408470983505;4938;4973.5523802857915;10208;10281.023302786223;10287.43419111956;10372.222083343779;10385;5356.196570514376;5466.863328416742;5479.972600136974;5501.972490137524;5515.641483303572;3975.5030621172355;4464.352668862996;4578.175928332866;4940.530649588283;4952.257161425743;3991.940120898189;4018.819153138116;4026.134381108076;4046.979765101156;4052.250333688277;1314.572763851752;1327.860574639649;1336.4854531005437;1340.3834236251435;1345.3407830163148;1130.1975597325827;1311.2460335307237;1328.6744747536916;1350.2843492948753;1355.1665725578698;8006.599670016476;8010.439269251096;8073.11195768465;8074.878876816852;8076.8384632307025;500.10730845440713;507.9111155547764;508.77359574989515;510.3314657798296;510.66806575726076;6246.3753624637175;6271.122042913996;6273.592216505913;6297.622142671455;6381.617102973836;8931.464112153291;10602.409638554278;10716.78566428667;10772.676819695422;11020.779584408267;10640;10649.680509584725;10860.837087443695;10862;10936.453177341102;7783.649735761905;8176.468529545679;8332.250097491255;8385.287250583646;8391.874121888177;7771.261730135628;7890.802729931797;7941.642626081724;8033.879491807745;8045.718399855977;9535.046495350687;9739.951300243736;9812.55843487059;9834;9896.109350158233;9741.659041933499;9834.557444914853;10205.897941020496;10226.590936362461;10253.384796912209;6964.756233531802;7143.071400717873;7385.556866588022;7609.847803044019;7812.84374312522;8182.386321025828;8184.959075204586;8215.917840821754;8216.178382161735;8217.30152937007;7492.250774922464;7702.5763583001235;7707.383409327128;7747.690092396241;7789.883151752615;7485.1017877855;7490.588017659081;7572.39420846342;7588.354989825927;7610.885836712565;6021.668808215591;7573.166951635206;7640.885386719093;7647.464677472746;7722.3049925506975;5842.532597392284;6903.378695917391;6999.440044796506;7094.255103214088;7120.0387947626405;7141.285871412817;7156.821079472847;7189.532680375968;7203.639818008974;7233.31283528064 00:15:31 INFO - PROCESS | 1689 | |4;prototype.html;326.73860911270987;329.21646481374324;329.94390953537896;330.3591033395213;335.9361721272958;6853.760118395857;6949.305069493048;6962.756303529378;6987.2663370346145;7003.0195772591815;6665.900126479137;6885;6912.239653638096;6913.27410621885;6957.686904089315;5096.261042148904;5097.872553186163;5114.795408183678;5140.511651393112;5142.717150556718;4841.104395686792;5111.591072714193;5113.51421614946;5126.615503837227;5137.023965446553;4939.67892087015;4943.530364615356;4962.305277261186;4974.228994505839;4978.377702787152;4941.728204948727;4942.6293028022865;4986.301917731521;4987.276844857475;4999.675021123615;4013.1171142348635;4105.85629502966;4121.52602450719;4206.074663574009;4240.745555266663;6582.539222254444;6607.405333519958;6607.636579988099;6626.039224312448;6635.5023373247195;5942.524598032147;5945.4946329562035;5950.077737950624;5950.571862752951;5986.311574168983;5463.426340234298;7427.591482468462;7442.925570744332;7459.813504662373;7465.6267186641;4776.880577985544;4777.474477807438;4785.282207668843;4797.304390863305;4806.711597304138;7839.96080019602;7919;7928.167542408022;7938.4046196536065;7945.562994035326;4738.431388233434;4790.808367665324;4824.155772739757;4830.9275360869615;4851.660383773102;4065.390191471303;4945.332380128709;4946.727929963887;4952.975235123801;4964;5806.970965145148;5924.8815023700145;5938.406159384027;5950.315713692894;5954.791582294685;6263.121063680877;6435.935640643534;7296.789947349387;7491.438142139361;7518.962405187939;1667.4164042584998;1717.6221231329087;1720.329071662053;1722.0098443394847;1722.3196837249216;1072.9967480405846;1078.9190810689072;1090.4275255490932;1095.1731442760665;1095.5453486803046;6832.385085342343;6873.931260687429;6888.483363747739;6892.414144797748;6895.207051189177;7708.961455192688;7709.151993280735;7737.381009519225;7739.020477116238;7741.032370953631;5163.3545806774155;5938.287405511366;6658.533902626769;6841.144856892888;6968.338007889242;3471.2710330830305;3962.2075584883137;4050.25070361984;4089.7750623715983;4138.296489596776;6842.863142737117;7334.716424625669;7763.72826951054;7892.408069394818;8178.918210817816;8048;8060;8081.111077781439;8097.595120244082;8105.594720263964;7954.403419743542;8185.71350002747;8194.918050819535;8196.5491897945;8210.137935516685;7834.921650783419;7837.568933708472;7847.529148251123;7857.9214207857185;7899.605019748875;7456.254374562501;7677.654505547152;7680.5391676499585;7694.07671079474;7730.961345193238;6595.472362210916;6948.305169483011;7806.687732490636;8152.83694326122;8191.262786349257;4836.274558816206;4881.219004959332;4881.877953051202;4888.193448081027;4893.314935909047;7601.353884919844;7787;7811.453198276066;7828.373730101464;7843.333316668147;7500;7523;7531.623418828927;7535.585542795199;7536.5101268417375;7338.926610734038;7502.324790768639;7504.849903002018;7505.66224519887;7521.323080922743;5954.7320370582565;7318.121825380776;7318.926810731825;7332.30343117403;7353.963230183815;7502.737404190827;7522.774316770506;7523.88714169277;7542.962285188539;7557.2820582044615;7113.324234197743;7341.963290183515;7352.411807055316;7378.889316660362;7391.852162956819 00:15:31 INFO - PROCESS | 1689 | |5;yui.html;675.4630069095069;716.5056111283216;721.9494635375522;722.1154086244348;730.0728075344313;14824.481143159992;14991.775123373158;15066.09603423794;15092.471763488253;15140.77288840667;13725.862741372583;13736.175829450214;14002.649933751662;14050.929745351259;14060.859391406082;700.271717413889;719.2663483247085;849.3247867944998;854.8076682746379;866.2160744526183;859.1966511311912;868.4615538366222;868.956552172392;870.9766024920724;870.9782255443633;879.8548239540468;908.3959167153835;914.6295750221171;915.2037727177365;935.0602644342426;885.6944354197856;897.7172190759923;899.0021076604963;908.4821651658524;908.6183802802839;639.7217210513442;651.9119918810948;658.5061204096927;666.4135560706595;666.4401902401958;14434.13395196281;14505.41978320866;14634;14642.926785366006;14699.779503307458;9723;12290.877091229062;12328.75342493145;12378.504859805687;12405.193662411913;8157.388195885333;8385.329173666092;10078.344907580984;10097.293189476739;10185.18518518524;3331.034000139981;3387.1870751019824;3464.3764122457947;3512.385332566816;3527.8059706716376;72461.63769181121;73254.16864578429;73519.89720154201;80544.79182812263;80694.386112278;7747.535147891144;7884.881726774103;8651.264642505457;9511.714648560554;9689.27330450205;20432.795672043387;20435.693464598044;20452.48868778263;20457.18171273162;20487.487812804502;7423.740169094056;7605.391568674493;7629.771106866803;7800.45396822217;7836.960815195887;4080.8979775505254;4122.546519882811;4157.376393540932;4200.201961627281;4226.021833455484;3578.8926332210076;3598.2803439312243;3609.8556057757396;3630.7276954228537;3632.636736326346;678.6131904814307;682.9829254268584;692.1452006771633;701.740356068258;702.9367356937901;530.4933788232229;552.1496894781991;594.6045879490091;614.8370681769335;621.7606221604624;9037.502937338379;9219.709240706306;9232.446053236694;9286;9313;499.03187815638273;503.41855157293384;571.8541771848152;614.6680792372069;636.5448704176536;3972.841086356513;3996.720229583901;4077.7145599808323;4098.057446787196;4106;78288.82566761503;78445.82331265036;79152.60423697844;79261.20738792654;79275.20724792793;74513;74592;74989.62505187439;75399;76392.61803690947;64468.67765661235;64951.02573461402;66795;66949;67656;8035;8105.918940810517;8232.259096681328;8265.297449716842;8267.83464330698;44446.555534445535;46106.538934610224;46271.537284628066;46659.53340466552;46758.59724208279;57546;63345.29892309714;63424.68287658532;64091;64350.35649643631;9830.901690982999;9876.753081173028;9902.257330700082;9970;10312.639057632947;10739.409332486788;10755.247132700948;10805.891941080488;11327.773444530898;11623.5350585979;10638.627648032281;10645.574177032831;10649.787004260026;10737.355758654505;10785.568577256821;10560.471976400995;10638.042576168182;10647;10774.892251077703;10804.24370294072;10279.126274266471;10332.845007324746;10373.170146388422;10394.948025259826;10477.895221047693;8403.478122766597;8494.277986371228;8686.78283042929;8745.344099192713;8779.165979231962;8829.984551776628;8913.55432228373;8956.328275379243;9120;9158.58786354629 00:15:31 INFO - PROCESS | 1689 | __end_tp_report 00:15:31 INFO - PROCESS | 1689 | __start_cc_report 00:15:31 INFO - PROCESS | 1689 | _x_x_mozilla_cycle_collect,351 00:15:31 INFO - PROCESS | 1689 | __end_cc_report 00:15:31 INFO - PROCESS | 1689 | __startTimestamp1454228131775__endTimestamp 00:15:31 INFO - PROCESS | 1689 | 00:15:31 INFO - PROCESS | 1689 | ------- Summary: start ------- 00:15:31 INFO - PROCESS | 1689 | Number of tests: 6 00:15:31 INFO - PROCESS | 1689 | 00:15:31 INFO - PROCESS | 1689 | [#0] dojo.html Cycles:165 Average:5772.51 Median:6052.27 stddev:630.65 (10.4%) stddev-sans-first:607.62 00:15:31 INFO - PROCESS | 1689 | Values: 3533.2 3550.9 3585.9 3606.9 3616.5 5774.2 5829.0 5839.2 5870.0 5885.2 5472.6 5648.7 5783.7 5788.6 5803.1 5173.7 5206.4 5223.0 5251.1 5270.7 4301.5 5171.4 5273.7 5307.4 5308.7 5297.2 5326.1 5336.0 5338.4 5354.9 5138.8 5287.2 5292.6 5328.4 5349.9 5123.1 5179.2 5194.8 5212.0 5231.3 5536.7 5597.1 5666.0 5726.1 5786.8 6145.6 6226.5 6229.5 6257.8 6266.4 6160.9 6213.2 6229.4 6232.6 6245.8 5865.1 5939.9 5952.7 5963.9 5964.4 6206.8 6220.4 6241.7 6242.0 6302.4 6212.7 6237.9 6241.6 6244.1 6277.2 6179.1 6225.3 6233.3 6260.7 6269.8 6108.6 6180.4 6217.1 6236.2 6269.5 6208.5 6213.1 6227.3 6229.4 6257.7 4872.3 4927.0 4930.2 4935.7 4952.2 4360.1 4390.5 4412.3 4415.7 4475.8 4632.0 5741.9 5783.2 5801.6 5833.8 5878.4 6148.7 6166.8 6243.8 6247.3 5689.0 5751.7 5778.2 5788.4 5836.1 5385.7 5401.1 5405.7 5409.8 5457.0 6188.2 6293.1 6349.0 6373.9 6387.3 6175.6 6206.2 6207.8 6221.6 6231.8 6330.3 6335.7 6337.3 6349.2 6380.6 6122.9 6146.2 6168.0 6194.8 6298.6 6205.3 6214.0 6220.7 6255.7 6278.1 6157.8 6220.2 6224.9 6236.2 6237.4 5932.5 6045.3 6052.3 6110.4 6204.2 5972.4 6038.3 6076.1 6090.9 6108.4 6114.3 6187.0 6196.5 6210.8 6233.8 5953.3 6048.2 6065.2 6100.8 6109.3 00:15:31 INFO - PROCESS | 1689 | 00:15:31 INFO - PROCESS | 1689 | [#1] ext.html Cycles:180 Average:69939.01 Median:39240.51 stddev:152742.11 (389.2%) stddev-sans-first:153081.49 00:15:31 INFO - PROCESS | 1689 | Values: 452.8 464.2 483.0 514.2 588.3 30748.8 36663.0 38425.0 38616.0 38787.0 43111.8 43583.6 43906.6 43944.3 44011.6 9708.9 9856.3 9970.4 9973.2 9993.2 9802.8 9900.6 9964.7 9965.9 9989.5 9937.0 10002.2 10037.8 10039.0 10041.0 8583.0 9760.7 9894.3 10000.1 10008.7 9695.2 9824.1 9865.3 9890.7 9891.0 40202.4 40373.0 40748.8 40770.8 40866.8 3213.5 3218.8 3256.5 3465.2 3799.7 28001.4 28393.9 28434.6 28513.4 28514.1 2770.8 2806.4 2864.6 2925.6 2998.7 422378.9 422871.0 464271.0 465284.0 467389.0 41756.6 57662.0 63701.7 64252.7 64618.0 70015.0 70177.6 70760.3 71108.0 71213.3 16015.4 16227.5 16387.2 16394.8 16404.5 12222.8 12295.3 12367.6 12448.1 12509.4 20179.2 20476.6 20502.9 20564.9 20831.0 7676.5 8939.4 9234.6 9249.8 9253.2 942.6 1038.8 1051.3 1051.6 1144.0 26154.7 28646.9 29800.6 29894.8 30127.5 903.3 985.0 1067.2 1097.4 1134.9 13183.0 14278.6 15127.7 15535.1 15561.0 626012.0 738238.0 741065.0 741278.6 742026.0 52340.0 58357.2 60347.1 60572.0 60587.0 1296.5 1433.5 1474.9 1479.2 1507.4 29148.0 30147.2 30464.5 31768.0 32285.4 45915.0 52565.5 52762.7 52977.7 53243.0 503067.0 507882.0 509798.0 510394.0 512039.0 34309.0 44795.3 44908.8 45946.5 46278.0 38235.0 44067.6 44177.8 44789.9 45579.1 31469.8 39092.4 39339.8 39715.0 40216.0 37990.2 38973.8 39025.6 39095.4 39141.2 37546.7 38018.4 38789.0 38985.6 39753.6 33765.8 34268.8 34832.3 34864.3 35065.8 24767.8 25438.6 25923.4 25994.2 27988.7 00:15:31 INFO - PROCESS | 1689 | 00:15:31 INFO - PROCESS | 1689 | [#2] jquery.html Cycles:180 Average:37748.55 Median:357.35 stddev:128005.73 (35821.0%) stddev-sans-first:128334.01 00:15:31 INFO - PROCESS | 1689 | Values: 352.2 362.5 365.5 368.6 368.8 15527.5 18934.4 19031.4 19130.7 19937.1 11480.7 12463.7 16889.9 19161.9 19184.2 3916.3 5178.2 5417.3 5431.7 5432.6 3377.3 5039.4 5939.1 5941.1 6056.6 5708.1 5885.6 5897.1 5942.7 5985.3 4565.6 5864.1 5865.9 5895.3 5930.2 5470.5 5517.6 5536.0 5549.6 5552.1 22573.5 23894.9 24143.9 24312.4 24501.5 1834.8 2190.1 2345.2 2380.3 2578.5 9278.9 10571.3 12336.0 13507.4 14373.9 1725.4 1749.4 1780.9 1793.5 1822.0 78350.6 96348.5 98926.0 99175.0 100057.0 8893.2 10984.7 11190.4 11300.8 11354.0 11887.8 12868.1 13309.6 13533.7 13553.3 8367.6 8407.3 8474.5 8486.3 8529.6 8478.7 8482.8 8508.9 8571.2 8575.5 3982.0 4189.3 4189.4 4289.4 4373.5 1835.3 1852.4 1866.8 1892.0 1895.4 907.9 919.8 935.9 995.5 1079.0 17420.6 18784.2 19198.2 19206.2 20321.0 936.8 947.2 961.2 981.8 981.8 10680.3 10886.9 10939.1 10953.1 10959.9 768022.0 770480.0 779103.8 786205.0 793476.0 87137.0 110390.0 111761.0 113230.0 114526.4 1121.3 1139.1 1140.1 1156.8 1168.4 17819.5 17858.8 17879.0 17972.5 17991.5 45211.5 46633.0 46828.8 48894.0 49018.5 61240.7 63128.4 63233.7 63262.9 63392.7 7433.4 7518.8 7613.8 7690.5 7696.8 9267.8 11450.8 11705.6 11919.3 12046.3 9710.6 9946.4 10174.7 10274.6 10378.6 10030.0 10149.6 10345.5 10568.3 10629.4 8717.4 10105.5 10467.4 10619.9 10744.4 7556.4 7663.3 7726.4 7739.3 7757.3 9481.3 10686.6 10697.0 10811.4 10865.6 00:15:31 INFO - PROCESS | 1689 | 00:15:31 INFO - PROCESS | 1689 | [#3] mootools.html Cycles:180 Average:6048.79 Median:510.50 stddev:3221.39 (631.0%) stddev-sans-first:3212.72 00:15:31 INFO - PROCESS | 1689 | Values: 1554.2 1562.2 1780.7 1884.4 1897.3 6933.0 8073.6 8795.6 8892.6 8966.6 7462.2 8559.7 8662.4 8731.7 8751.4 2126.4 2471.6 2492.3 2495.5 2505.3 2494.4 2509.7 2509.8 2536.7 2545.9 1945.6 2072.5 2435.8 2471.8 2541.4 2259.0 2277.5 2476.4 2485.3 2503.2 2513.5 2518.7 2519.5 2533.5 2534.8 8822.0 8831.8 8853.9 8903.4 8911.6 5272.7 5420.8 5437.3 5437.8 5446.5 3602.2 3688.2 3709.6 3735.1 3739.8 1053.8 1074.8 1079.2 1087.3 1108.7 11852.0 11999.6 12018.3 12041.5 12078.6 4859.2 4865.0 4929.4 4938.0 4973.6 10208.0 10281.0 10287.4 10372.2 10385.0 5356.2 5466.9 5480.0 5502.0 5515.6 3975.5 4464.4 4578.2 4940.5 4952.3 3991.9 4018.8 4026.1 4047.0 4052.3 1314.6 1327.9 1336.5 1340.4 1345.3 1130.2 1311.2 1328.7 1350.3 1355.2 8006.6 8010.4 8073.1 8074.9 8076.8 500.1 507.9 508.8 510.3 510.7 6246.4 6271.1 6273.6 6297.6 6381.6 8931.5 10602.4 10716.8 10772.7 11020.8 10640.0 10649.7 10860.8 10862.0 10936.5 7783.6 8176.5 8332.3 8385.3 8391.9 7771.3 7890.8 7941.6 8033.9 8045.7 9535.0 9740.0 9812.6 9834.0 9896.1 9741.7 9834.6 10205.9 10226.6 10253.4 6964.8 7143.1 7385.6 7609.8 7812.8 8182.4 8185.0 8215.9 8216.2 8217.3 7492.3 7702.6 7707.4 7747.7 7789.9 7485.1 7490.6 7572.4 7588.4 7610.9 6021.7 7573.2 7640.9 7647.5 7722.3 5842.5 6903.4 6999.4 7094.3 7120.0 7141.3 7156.8 7189.5 7203.6 7233.3 00:15:31 INFO - PROCESS | 1689 | 00:15:31 INFO - PROCESS | 1689 | [#4] prototype.html Cycles:180 Average:6036.15 Median:6842.00 stddev:1969.84 (28.8%) stddev-sans-first:1928.19 00:15:31 INFO - PROCESS | 1689 | Values: 326.7 329.2 329.9 330.4 335.9 6853.8 6949.3 6962.8 6987.3 7003.0 6665.9 6885.0 6912.2 6913.3 6957.7 5096.3 5097.9 5114.8 5140.5 5142.7 4841.1 5111.6 5113.5 5126.6 5137.0 4939.7 4943.5 4962.3 4974.2 4978.4 4941.7 4942.6 4986.3 4987.3 4999.7 4013.1 4105.9 4121.5 4206.1 4240.7 6582.5 6607.4 6607.6 6626.0 6635.5 5942.5 5945.5 5950.1 5950.6 5986.3 5463.4 7427.6 7442.9 7459.8 7465.6 4776.9 4777.5 4785.3 4797.3 4806.7 7840.0 7919.0 7928.2 7938.4 7945.6 4738.4 4790.8 4824.2 4830.9 4851.7 4065.4 4945.3 4946.7 4953.0 4964.0 5807.0 5924.9 5938.4 5950.3 5954.8 6263.1 6435.9 7296.8 7491.4 7519.0 1667.4 1717.6 1720.3 1722.0 1722.3 1073.0 1078.9 1090.4 1095.2 1095.5 6832.4 6873.9 6888.5 6892.4 6895.2 7709.0 7709.2 7737.4 7739.0 7741.0 5163.4 5938.3 6658.5 6841.1 6968.3 3471.3 3962.2 4050.3 4089.8 4138.3 6842.9 7334.7 7763.7 7892.4 8178.9 8048.0 8060.0 8081.1 8097.6 8105.6 7954.4 8185.7 8194.9 8196.5 8210.1 7834.9 7837.6 7847.5 7857.9 7899.6 7456.3 7677.7 7680.5 7694.1 7731.0 6595.5 6948.3 7806.7 8152.8 8191.3 4836.3 4881.2 4881.9 4888.2 4893.3 7601.4 7787.0 7811.5 7828.4 7843.3 7500.0 7523.0 7531.6 7535.6 7536.5 7338.9 7502.3 7504.8 7505.7 7521.3 5954.7 7318.1 7318.9 7332.3 7354.0 7502.7 7522.8 7523.9 7543.0 7557.3 7113.3 7342.0 7352.4 7378.9 7391.9 00:15:31 INFO - PROCESS | 1689 | 00:15:31 INFO - PROCESS | 1689 | [#5] yui.html Cycles:180 Average:17116.64 Median:32801.47 stddev:23574.09 (71.9%) stddev-sans-first:23607.90 00:15:31 INFO - PROCESS | 1689 | Values: 675.5 716.5 721.9 722.1 730.1 14824.5 14991.8 15066.1 15092.5 15140.8 13725.9 13736.2 14002.6 14050.9 14060.9 700.3 719.3 849.3 854.8 866.2 859.2 868.5 869.0 871.0 871.0 879.9 908.4 914.6 915.2 935.1 885.7 897.7 899.0 908.5 908.6 639.7 651.9 658.5 666.4 666.4 14434.1 14505.4 14634.0 14642.9 14699.8 9723.0 12290.9 12328.8 12378.5 12405.2 8157.4 8385.3 10078.3 10097.3 10185.2 3331.0 3387.2 3464.4 3512.4 3527.8 72461.6 73254.2 73519.9 80544.8 80694.4 7747.5 7884.9 8651.3 9511.7 9689.3 20432.8 20435.7 20452.5 20457.2 20487.5 7423.7 7605.4 7629.8 7800.5 7837.0 4080.9 4122.5 4157.4 4200.2 4226.0 3578.9 3598.3 3609.9 3630.7 3632.6 678.6 683.0 692.1 701.7 702.9 530.5 552.1 594.6 614.8 621.8 9037.5 9219.7 9232.4 9286.0 9313.0 499.0 503.4 571.9 614.7 636.5 3972.8 3996.7 4077.7 4098.1 4106.0 78288.8 78445.8 79152.6 79261.2 79275.2 74513.0 74592.0 74989.6 75399.0 76392.6 64468.7 64951.0 66795.0 66949.0 67656.0 8035.0 8105.9 8232.3 8265.3 8267.8 44446.6 46106.5 46271.5 46659.5 46758.6 57546.0 63345.3 63424.7 64091.0 64350.4 9830.9 9876.8 9902.3 9970.0 10312.6 10739.4 10755.2 10805.9 11327.8 11623.5 10638.6 10645.6 10649.8 10737.4 10785.6 10560.5 10638.0 10647.0 10774.9 10804.2 10279.1 10332.8 10373.2 10394.9 10477.9 8403.5 8494.3 8686.8 8745.3 8779.2 8830.0 8913.6 8956.3 9120.0 9158.6 00:15:31 INFO - PROCESS | 1689 | -------- Summary: end -------- 00:15:31 INFO - PROCESS | 1689 | 00:15:32 INFO - TEST-INFO | 1689: exit 0 00:15:32 INFO - TEST-OK | dromaeo_css | took 1111503ms 00:15:32 INFO - TEST-START | kraken 00:15:32 INFO - operating with platform_type : mac_ 00:15:32 INFO - Initialising browser for kraken test... 00:15:32 INFO - TEST-INFO | started process 1696 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpfAMoMl/profile http://localhost:49273/getInfo.html) 00:15:32 INFO - PROCESS | 1696 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 00:15:35 INFO - PROCESS | 1696 | __metrics Screen width/height:1600/1200 00:15:35 INFO - PROCESS | 1696 | colorDepth:24 00:15:35 INFO - PROCESS | 1696 | Browser inner width/height: 1024/689 00:15:35 INFO - PROCESS | 1696 | __metrics 00:15:35 INFO - PROCESS | 1696 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:15:35 INFO - PROCESS | 1696 | 00:15:35 INFO - PROCESS | 1696 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 00:15:35 INFO - PROCESS | 1696 | 00:15:36 INFO - TEST-INFO | 1696: exit 0 00:15:36 INFO - Browser initialized. 00:15:36 INFO - Running cycle 1/1 for kraken test... 00:15:36 INFO - TEST-INFO | started process 1699 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpfAMoMl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:15:48 INFO - PROCESS | 1699 | RSS: Main: 255987712 00:15:48 INFO - PROCESS | 1699 | 00:15:50 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 00:15:51 INFO - PROCESS | 1699 | RSS: Main: 269807616 00:15:51 INFO - PROCESS | 1699 | 00:15:54 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 00:15:54 INFO - PROCESS | 1699 | RSS: Main: 276914176 00:15:54 INFO - PROCESS | 1699 | 00:15:58 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 00:15:59 INFO - PROCESS | 1699 | RSS: Main: 282275840 00:15:59 INFO - PROCESS | 1699 | 00:16:01 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 00:16:01 INFO - PROCESS | 1699 | RSS: Main: 282947584 00:16:01 INFO - PROCESS | 1699 | 00:16:03 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:16:04 INFO - PROCESS | 1699 | RSS: Main: 283041792 00:16:04 INFO - PROCESS | 1699 | 00:16:06 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 00:16:07 INFO - PROCESS | 1699 | RSS: Main: 283652096 00:16:07 INFO - PROCESS | 1699 | 00:16:10 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 00:16:10 INFO - PROCESS | 1699 | RSS: Main: 284045312 00:16:10 INFO - PROCESS | 1699 | 00:16:13 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 00:16:14 INFO - PROCESS | 1699 | RSS: Main: 284286976 00:16:14 INFO - PROCESS | 1699 | 00:16:15 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:16:16 INFO - PROCESS | 1699 | RSS: Main: 284274688 00:16:16 INFO - PROCESS | 1699 | 00:16:18 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:16:18 INFO - PROCESS | 1699 | RSS: Main: 283082752 00:16:18 INFO - PROCESS | 1699 | 00:16:20 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:16:21 INFO - PROCESS | 1699 | RSS: Main: 283348992 00:16:21 INFO - PROCESS | 1699 | 00:16:24 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:16:24 INFO - PROCESS | 1699 | RSS: Main: 284729344 00:16:24 INFO - PROCESS | 1699 | 00:16:27 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:16:27 INFO - PROCESS | 1699 | RSS: Main: 283295744 00:16:27 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 00:16:29 INFO - PROCESS | 1699 | RSS: Main: 284766208 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | __start_tp_report 00:16:29 INFO - PROCESS | 1699 | _x_x_mozilla_page_load 00:16:29 INFO - PROCESS | 1699 | _x_x_mozilla_page_load_details 00:16:29 INFO - PROCESS | 1699 | |i|pagename|runs| 00:16:29 INFO - PROCESS | 1699 | |0;ai-astar;115;106;114;113;116;125;114;115;118;114 00:16:29 INFO - PROCESS | 1699 | |1;audio-beat-detection;154;106;171;179;154;139;141;123;194;154 00:16:29 INFO - PROCESS | 1699 | |2;audio-dft;272;271;200;256;231;277;193;282;287;200 00:16:29 INFO - PROCESS | 1699 | |3;audio-fft;81;70;72;125;53;75;90;86;101;55 00:16:29 INFO - PROCESS | 1699 | |4;audio-oscillator;80;90;114;77;79;83;113;80;83;111 00:16:29 INFO - PROCESS | 1699 | |5;imaging-gaussian-blur;104;95;88;95;88;93;88;95;109;94 00:16:29 INFO - PROCESS | 1699 | |6;imaging-darkroom;96;98;98;96;99;98;98;98;97;96 00:16:29 INFO - PROCESS | 1699 | |7;imaging-desaturate;93;93;89;92;94;94;90;91;91;92 00:16:29 INFO - PROCESS | 1699 | |8;json-parse-financial;56;57;55;56;55;57;53;63;56;56 00:16:29 INFO - PROCESS | 1699 | |9;json-stringify-tinderbox;63;64;71;64;87;71;66;67;66;67 00:16:29 INFO - PROCESS | 1699 | |10;stanford-crypto-aes;87;83;86;86;86;83;88;86;85;86 00:16:29 INFO - PROCESS | 1699 | |11;stanford-crypto-ccm;122;133;130;143;138;114;122;129;137;141 00:16:29 INFO - PROCESS | 1699 | |12;stanford-crypto-pbkdf2;140;143;139;136;141;143;143;139;139;138 00:16:29 INFO - PROCESS | 1699 | |13;stanford-crypto-sha256-iterative;66;68;66;69;70;73;84;99;98;78 00:16:29 INFO - PROCESS | 1699 | __end_tp_report 00:16:29 INFO - PROCESS | 1699 | __start_cc_report 00:16:29 INFO - PROCESS | 1699 | _x_x_mozilla_cycle_collect,882 00:16:29 INFO - PROCESS | 1699 | __end_cc_report 00:16:29 INFO - PROCESS | 1699 | __startTimestamp1454228189759__endTimestamp 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | ------- Summary: start ------- 00:16:29 INFO - PROCESS | 1699 | Number of tests: 14 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:4.69 (4.1%) stddev-sans-first:4.97 00:16:29 INFO - PROCESS | 1699 | Values: 115.0 106.0 114.0 113.0 116.0 125.0 114.0 115.0 118.0 114.0 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:154.00 stddev:26.06 (16.9%) stddev-sans-first:27.62 00:16:29 INFO - PROCESS | 1699 | Values: 154.0 106.0 171.0 179.0 154.0 139.0 141.0 123.0 194.0 154.0 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | [#2] audio-dft Cycles:10 Average:246.90 Median:271.50 stddev:37.41 (13.8%) stddev-sans-first:38.56 00:16:29 INFO - PROCESS | 1699 | Values: 272.0 271.0 200.0 256.0 231.0 277.0 193.0 282.0 287.0 200.0 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | [#3] audio-fft Cycles:10 Average:80.80 Median:73.50 stddev:21.45 (29.2%) stddev-sans-first:22.75 00:16:29 INFO - PROCESS | 1699 | Values: 81.0 70.0 72.0 125.0 53.0 75.0 90.0 86.0 101.0 55.0 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:80.00 stddev:15.36 (19.2%) stddev-sans-first:15.77 00:16:29 INFO - PROCESS | 1699 | Values: 80.0 90.0 114.0 77.0 79.0 83.0 113.0 80.0 83.0 111.0 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | [#5] imaging-gaussian-blur Cycles:10 Average:94.90 Median:93.50 stddev:6.90 (7.4%) stddev-sans-first:6.49 00:16:29 INFO - PROCESS | 1699 | Values: 104.0 95.0 88.0 95.0 88.0 93.0 88.0 95.0 109.0 94.0 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | [#6] imaging-darkroom Cycles:10 Average:97.40 Median:98.00 stddev:1.07 (1.1%) stddev-sans-first:1.01 00:16:29 INFO - PROCESS | 1699 | Values: 96.0 98.0 98.0 96.0 99.0 98.0 98.0 98.0 97.0 96.0 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | [#7] imaging-desaturate Cycles:10 Average:91.90 Median:92.50 stddev:1.66 (1.8%) stddev-sans-first:1.72 00:16:29 INFO - PROCESS | 1699 | Values: 93.0 93.0 89.0 92.0 94.0 94.0 90.0 91.0 91.0 92.0 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:2.59 (4.6%) stddev-sans-first:2.74 00:16:29 INFO - PROCESS | 1699 | Values: 56.0 57.0 55.0 56.0 55.0 57.0 53.0 63.0 56.0 56.0 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:67.00 stddev:7.01 (10.5%) stddev-sans-first:7.14 00:16:29 INFO - PROCESS | 1699 | Values: 63.0 64.0 71.0 64.0 87.0 71.0 66.0 67.0 66.0 67.0 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:1.58 (1.8%) stddev-sans-first:1.59 00:16:29 INFO - PROCESS | 1699 | Values: 87.0 83.0 86.0 86.0 86.0 83.0 88.0 86.0 85.0 86.0 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:135.00 stddev:9.36 (6.9%) stddev-sans-first:9.36 00:16:29 INFO - PROCESS | 1699 | Values: 122.0 133.0 130.0 143.0 138.0 114.0 122.0 129.0 137.0 141.0 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.10 Median:140.50 stddev:2.38 (1.7%) stddev-sans-first:2.52 00:16:29 INFO - PROCESS | 1699 | Values: 140.0 143.0 139.0 136.0 141.0 143.0 143.0 139.0 139.0 138.0 00:16:29 INFO - PROCESS | 1699 | 00:16:29 INFO - PROCESS | 1699 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.10 Median:75.50 stddev:12.59 (16.7%) stddev-sans-first:12.70 00:16:29 INFO - PROCESS | 1699 | Values: 66.0 68.0 66.0 69.0 70.0 73.0 84.0 99.0 98.0 78.0 00:16:29 INFO - PROCESS | 1699 | -------- Summary: end -------- 00:16:29 INFO - PROCESS | 1699 | 00:16:30 INFO - TEST-INFO | 1699: exit 0 00:16:30 INFO - TEST-OK | kraken | took 58123ms 00:16:30 INFO - SUITE-END | took 1169s 00:16:30 INFO - Completed test suite (00:19:30) 00:16:30 INFO - Working with test: dromaeo_css 00:16:30 INFO - Generating results file: dromaeo_css 00:16:30 INFO - Working with test: kraken 00:16:30 INFO - Generating results file: kraken 00:16:30 INFO - javascript benchmark 00:16:30 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:16:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 00:16:31 INFO - process_Request line: dromaeo_css 7536.77 graph.html#tests=[[72,64,61]] 00:16:31 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:16:31 INFO - process_Request line: kraken 1528.10 graph.html#tests=[[232,64,61]] 00:16:31 INFO - RETURN: dromaeo_css: 7536.77 00:16:31 INFO - RETURN: kraken: 1528.10 00:16:31 INFO - javascript benchmark 00:16:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3533.2050288685045, 3550.9112272193192, 3585.8744943926968, 3606.8557257709695, 3616.529851119354, 5774.220480235167, 5829.0, 5839.153322768196, 5870.031444811611, 5885.176075349449, 5472.589555783322, 5648.74580643871, 5783.710814459281, 5788.594798364116, 5803.071508558632, 5173.715445650497, 5206.427292997767, 5223.0, 5251.081060814361, 5270.683758974455, 4301.548337424572, 5171.379434467869, 5273.657212281209, 5307.389650190239, 5308.6814791112465, 5297.152455607104, 5326.067938110815, 5336.039512887679, 5338.439463856297, 5354.9196762048605, 5138.845834624967, 5287.206918962148, 5292.550133238679, 5328.413874473805, 5349.893002139955, 5123.052235336475, 5179.19722443022, 5194.792208311663, 5211.957608478319, 5231.2937753403185, 5536.667799931976, 5597.132444471114, 5666.016894087078, 5726.055200891889, 5786.768529258825, 6145.586515101507, 6226.452706069951, 6229.53278504114, 6257.812265632038, 6266.373362663743, 6160.938390616081, 6213.161223234851, 6229.408206220447, 6232.563720539564, 6245.812625621239, 5865.120231965197, 5939.940600593982, 5952.7023648817385, 5963.940360596382, 5964.403559644001, 6206.813795586139, 6220.440160385497, 6241.7191226394925, 6242.0, 6302.369763023753, 6212.72042758077, 6237.937620623827, 6241.625502469867, 6244.12582238487, 6277.18396608438, 6179.134921111048, 6225.252969643671, 6233.34549872266, 6260.718267677966, 6269.780557680459, 6108.584917381041, 6180.351063138306, 6217.098520714471, 6236.220472440945, 6269.529785266123, 6208.4722798562625, 6213.099100630383, 6227.314995350508, 6229.3770622937345, 6257.655828929362, 4872.317875497433, 4927.0, 4930.235813448921, 4935.679180853233, 4952.158133117378, 4360.106178233455, 4390.473143222834, 4412.294032954776, 4415.735055896656, 4475.753833539186, 4631.957809492837, 5741.942580574141, 5783.248177736951, 5801.622894511843, 5833.766649334064, 5878.353381128072, 6148.739508400767, 6166.753329866845, 6243.8126856194385, 6247.2815626202655, 5689.004424225744, 5751.654900705971, 5778.219940308005, 5788.421157884262, 5836.124581312837, 5385.676859388449, 5401.135818269058, 5405.729713514309, 5409.810656626999, 5457.0, 6188.164597779422, 6293.118963345044, 6349.0476428536085, 6373.936260637334, 6387.265464471552, 6175.59858609189, 6206.193194884636, 6207.751689932352, 6221.564490485623, 6231.844203894758, 6330.335314792064, 6335.714892829741, 6337.271213810286, 6349.206349206349, 6380.649064301508, 6122.908156377569, 6146.186874872013, 6168.0439531872635, 6194.845128871814, 6298.590591611531, 6205.348438413902, 6213.96893015532, 6220.657863817352, 6255.71849266775, 6278.0896769967185, 6157.815265542041, 6220.191375121205, 6224.875502489835, 6236.220472440945, 6237.376262373727, 5932.525397968066, 6045.274567051982, 6052.273727152769, 6110.40687992437, 6204.224471941007, 5972.402759723993, 6038.305594856648, 6076.088586712029, 6090.908636370546, 6108.389161083856, 6114.327423983447, 6186.969065154645, 6196.47329976957, 6210.844728881814, 6233.844153896189, 5953.315368732651, 6048.153258543719, 6065.211522502046, 6100.823402702991, 6109.327973922776], "unit": "score", "name": "dojo.html", "value": 5734.082072112829}, {"lowerIsBetter": false, "replicates": [452.76456242753767, 464.24560089853986, 482.9613630909528, 514.1850167484537, 588.2734822494219, 30748.846255768716, 36663.0, 38425.0, 38616.034599135004, 38787.0, 43111.78444107783, 43583.564164358344, 43906.56093439065, 43944.3408348875, 44011.55988440115, 9708.902910970888, 9856.310058295921, 9970.35192712475, 9973.202143828476, 9993.150582200522, 9802.803943921117, 9900.603975840993, 9964.701058968243, 9965.850512242323, 9989.450580218085, 9937.0, 10002.249831262649, 10037.849432258521, 10039.0, 10041.04610062043, 8583.0, 9760.658376956773, 9894.307398482073, 10000.149987251092, 10008.699739007805, 9695.175910047654, 9824.066713662261, 9865.260105492045, 9890.653827116017, 9891.0, 40202.39696404556, 40373.0, 40748.79625601853, 40770.79614601908, 40866.795666021775, 3213.469777486712, 3218.758593105503, 3256.495243237302, 3465.220325426759, 3799.715021373408, 28001.439971200463, 28393.858030709922, 28434.57348139759, 28513.429731405464, 28514.14457566276, 2770.7921905857143, 2806.4387122575363, 2864.598956146141, 2925.6196694429586, 2998.7151220634005, 422378.88810556056, 422871.0, 464271.0, 465284.0, 467389.0, 41756.58243417527, 57662.0, 63701.681491593175, 64252.678736606016, 64618.0, 70015.0, 70177.64911175412, 70760.2923970764, 71108.0, 71213.28786712067, 16015.359385624677, 16227.513174604781, 16387.180640967905, 16394.75407868859, 16404.507864764077, 12222.816657750142, 12295.32375719344, 12367.567135150226, 12448.066395020409, 12509.374531273399, 20179.192832286542, 20476.590468190552, 20502.897485512476, 20564.897175514026, 20831.0, 7676.501027433199, 8939.418937769024, 9234.584443700049, 9249.815003699889, 9253.213476854407, 942.6465075596651, 1038.787048655024, 1051.3113910388709, 1051.5530899367739, 1143.9656810295705, 26154.692265387035, 28646.856765716453, 29800.552991705143, 29894.83150558291, 30127.548086778716, 903.2593273515786, 984.9606015759433, 1067.2315932528568, 1097.3964319624174, 1134.8921852424007, 13183.0, 14278.64352886474, 15127.697446051017, 15535.145566993699, 15561.0, 626012.0, 738238.0, 741065.0, 741278.5872141317, 742026.0, 52340.0, 58357.249282521596, 60347.09479357726, 60572.0, 60587.0, 1296.4895896280916, 1433.4767809749367, 1474.9262536873327, 1479.2234077109604, 1507.3744396075506, 29147.979820706172, 30147.19116852996, 30464.543031854097, 31768.0, 32285.35429291448, 45915.0, 52565.47434525606, 52762.73618631882, 52977.7351113242, 53243.0, 503067.0, 507882.0, 509798.0, 510394.0, 512039.0, 34309.0, 44795.32807007832, 44908.77545612251, 45946.540534595566, 46278.0, 38235.0, 44067.55932440763, 44177.77911110424, 44789.88025299263, 45579.08841823211, 31469.8426507866, 39092.41361379639, 39339.80330098446, 39715.0, 40216.0, 37990.24019519649, 38973.805130974164, 39025.6097439022, 39095.41356879592, 39141.2171756569, 37546.68586599456, 38018.429723553614, 38789.03027424337, 38985.6101438982, 39753.60246397499, 33765.81819636301, 34268.82865585656, 34832.30335393227, 34864.30271394608, 35065.824670876485, 24767.752322476543, 25438.600876951205, 25923.351916201493, 25994.220173394828, 27988.72011279861], "unit": "score", "name": "ext.html", "value": 20328.607381133115}, {"lowerIsBetter": false, "replicates": [352.16712474996643, 362.5287126735244, 365.45182226660006, 368.5724559510968, 368.8008475423272, 15527.534173974798, 18934.43196704101, 19031.429057128273, 19130.71303930442, 19937.10283037263, 11480.71298217545, 12463.68840778981, 16889.91555042223, 19161.94609296488, 19184.232630694754, 3916.2950668879735, 5178.223266510016, 5417.26866872971, 5431.701256430894, 5432.619716619838, 3377.257003459235, 5039.420466646327, 5939.079442686369, 5941.079132734411, 6056.576039677225, 5708.08670612702, 5885.617434866741, 5897.056470964647, 5942.741758131904, 5985.34161242263, 4565.589096981254, 5864.061750119981, 5865.941340586583, 5895.263092113486, 5930.199423077894, 5470.5350045245805, 5517.613767036309, 5535.972320138414, 5549.5837812163845, 5552.08390615548, 22573.54852902933, 23894.880525597433, 24143.913523891468, 24312.39219019521, 24501.50996980068, 1834.7706536682915, 2190.113004233288, 2345.2260753951155, 2380.345405013618, 2578.4714133602565, 9278.907210927871, 10571.260011799177, 12336.0, 13507.392167352493, 14373.85626143746, 1725.413359457778, 1749.4401791426749, 1780.8931464112065, 1793.4888556761261, 1821.9908900455546, 78350.60824695897, 96348.51825740826, 98926.0, 99175.0082499173, 100057.0, 8893.199612034818, 10984.670459886056, 11190.440477976068, 11300.773984520429, 11353.978141967262, 11887.821682674767, 12868.099233053783, 13309.600711978655, 13533.661658458617, 13553.25457099869, 8367.581620918929, 8407.327413806881, 8474.491530508189, 8486.321094312563, 8529.57352132391, 8478.74563763088, 8482.830343393098, 8508.915315747681, 8571.22858942698, 8575.528345940907, 3981.980090099531, 4189.287821070426, 4189.4344263524035, 4289.442372491556, 4373.540778218305, 1835.3484512997961, 1852.3516769130697, 1866.8039855815216, 1891.9810801892081, 1895.3934740882785, 907.8728977943093, 919.7562645898843, 935.9017303183203, 995.542050656706, 1078.9784204316027, 17420.640853141875, 18784.154713037948, 19198.232070717295, 19206.231750730094, 20321.0, 936.784539555906, 947.2185447006248, 961.1541843177959, 981.8183636027358, 981.8478135888948, 10680.305780124267, 10886.945565272123, 10939.12487001038, 10953.068989135852, 10959.890401095887, 768022.0, 770480.0, 779103.7649036751, 786205.0, 793476.0, 87137.0, 110390.0, 111761.0, 113230.0, 114526.4273678643, 1121.315997241682, 1139.1342579639368, 1140.1391949078393, 1156.7975604269388, 1168.4391492083848, 17819.46541603754, 17858.821411785717, 17879.0, 17972.460826175236, 17991.460256192335, 45211.54788452073, 46633.0, 46828.76585617186, 48894.0, 49018.50981490282, 61240.69379653073, 63128.368716314086, 63233.68383158055, 63262.90494660516, 63392.68303658452, 7433.424041470419, 7518.774436766906, 7613.809654758454, 7690.538567685733, 7696.8460630788195, 9267.814643706954, 11450.770984580095, 11705.590304339306, 11919.3444360561, 12046.337451439904, 9710.6115755369, 9946.35348702332, 10174.745631359276, 10274.589016439259, 10378.584856605954, 10029.99700029991, 10149.64476243328, 10345.482725863827, 10568.313059651098, 10629.36223826542, 8717.433366831136, 10105.545250463894, 10467.408521900341, 10619.893801061891, 10744.355338679705, 7556.433267504849, 7663.27198916102, 7726.3818894487185, 7739.30346268816, 7757.340626046624, 9481.336306458481, 10686.57253709843, 10697.037266646039, 10811.405372704578, 10865.619703310345], "unit": "score", "name": "jquery.html", "value": 9092.638124094705}, {"lowerIsBetter": false, "replicates": [1554.1529866222907, 1562.2032763290717, 1780.6794776940146, 1884.3593178319368, 1897.2885168061978, 6932.965335173317, 8073.636686349114, 8795.648174073038, 8892.599833007514, 8966.641334346617, 7462.21646727094, 8559.743207703763, 8662.393632445732, 8731.694390696326, 8751.431156974792, 2126.4258650164447, 2471.5921872890954, 2492.277239600514, 2495.5258500884775, 2505.3110394641435, 2494.4387512809562, 2509.6611957385703, 2509.7866681332016, 2536.6575512305785, 2545.898164073435, 1945.5816999345138, 2072.4715197624587, 2435.7686019828175, 2471.789897858684, 2541.3519552514176, 2258.9661155082686, 2277.487565297811, 2476.3932836455006, 2485.3041148478455, 2503.236512863576, 2513.459606184679, 2518.6851643544555, 2519.5212909547313, 2533.518631460035, 2534.7845433138204, 8821.955890220572, 8831.823363532758, 8853.911460885372, 8903.37676362655, 8911.643534258621, 5272.736363181864, 5420.810271640474, 5437.32033495813, 5437.755301011464, 5446.482584154499, 3602.2435288589168, 3688.17016171362, 3709.5548534176073, 3735.122246272124, 3739.775613463201, 1053.8155822731069, 1074.8065348237315, 1079.1528650009705, 1087.26066274933, 1108.717277094344, 11852.0, 11999.580014699444, 12018.338991355471, 12041.518339266418, 12078.637640870787, 4859.222524396079, 4864.951350486521, 4929.408470983505, 4938.0, 4973.5523802857915, 10208.0, 10281.023302786223, 10287.43419111956, 10372.222083343779, 10385.0, 5356.196570514376, 5466.863328416742, 5479.972600136974, 5501.972490137524, 5515.641483303572, 3975.5030621172355, 4464.352668862996, 4578.175928332866, 4940.530649588283, 4952.257161425743, 3991.940120898189, 4018.819153138116, 4026.134381108076, 4046.979765101156, 4052.250333688277, 1314.572763851752, 1327.860574639649, 1336.4854531005437, 1340.3834236251435, 1345.3407830163148, 1130.1975597325827, 1311.2460335307237, 1328.6744747536916, 1350.2843492948753, 1355.1665725578698, 8006.599670016476, 8010.439269251096, 8073.11195768465, 8074.878876816852, 8076.8384632307025, 500.10730845440713, 507.9111155547764, 508.77359574989515, 510.3314657798296, 510.66806575726076, 6246.3753624637175, 6271.122042913996, 6273.592216505913, 6297.622142671455, 6381.617102973836, 8931.464112153291, 10602.409638554278, 10716.78566428667, 10772.676819695422, 11020.779584408267, 10640.0, 10649.680509584725, 10860.837087443695, 10862.0, 10936.453177341102, 7783.649735761905, 8176.468529545679, 8332.250097491255, 8385.287250583646, 8391.874121888177, 7771.261730135628, 7890.802729931797, 7941.642626081724, 8033.879491807745, 8045.718399855977, 9535.046495350687, 9739.951300243736, 9812.55843487059, 9834.0, 9896.109350158233, 9741.659041933499, 9834.557444914853, 10205.897941020496, 10226.590936362461, 10253.384796912209, 6964.756233531802, 7143.071400717873, 7385.556866588022, 7609.847803044019, 7812.84374312522, 8182.386321025828, 8184.959075204586, 8215.917840821754, 8216.178382161735, 8217.30152937007, 7492.250774922464, 7702.5763583001235, 7707.383409327128, 7747.690092396241, 7789.883151752615, 7485.1017877855, 7490.588017659081, 7572.39420846342, 7588.354989825927, 7610.885836712565, 6021.668808215591, 7573.166951635206, 7640.885386719093, 7647.464677472746, 7722.3049925506975, 5842.532597392284, 6903.378695917391, 6999.440044796506, 7094.255103214088, 7120.0387947626405, 7141.285871412817, 7156.821079472847, 7189.532680375968, 7203.639818008974, 7233.31283528064], "unit": "score", "name": "mootools.html", "value": 4850.026690199075}, {"lowerIsBetter": false, "replicates": [326.73860911270987, 329.21646481374324, 329.94390953537896, 330.3591033395213, 335.9361721272958, 6853.760118395857, 6949.305069493048, 6962.756303529378, 6987.2663370346145, 7003.0195772591815, 6665.900126479137, 6885.0, 6912.239653638096, 6913.27410621885, 6957.686904089315, 5096.261042148904, 5097.872553186163, 5114.795408183678, 5140.511651393112, 5142.717150556718, 4841.104395686792, 5111.591072714193, 5113.51421614946, 5126.615503837227, 5137.023965446553, 4939.67892087015, 4943.530364615356, 4962.305277261186, 4974.228994505839, 4978.377702787152, 4941.728204948727, 4942.6293028022865, 4986.301917731521, 4987.276844857475, 4999.675021123615, 4013.1171142348635, 4105.85629502966, 4121.52602450719, 4206.074663574009, 4240.745555266663, 6582.539222254444, 6607.405333519958, 6607.636579988099, 6626.039224312448, 6635.5023373247195, 5942.524598032147, 5945.4946329562035, 5950.077737950624, 5950.571862752951, 5986.311574168983, 5463.426340234298, 7427.591482468462, 7442.925570744332, 7459.813504662373, 7465.6267186641, 4776.880577985544, 4777.474477807438, 4785.282207668843, 4797.304390863305, 4806.711597304138, 7839.96080019602, 7919.0, 7928.167542408022, 7938.4046196536065, 7945.562994035326, 4738.431388233434, 4790.808367665324, 4824.155772739757, 4830.9275360869615, 4851.660383773102, 4065.390191471303, 4945.332380128709, 4946.727929963887, 4952.975235123801, 4964.0, 5806.970965145148, 5924.8815023700145, 5938.406159384027, 5950.315713692894, 5954.791582294685, 6263.121063680877, 6435.935640643534, 7296.789947349387, 7491.438142139361, 7518.962405187939, 1667.4164042584998, 1717.6221231329087, 1720.329071662053, 1722.0098443394847, 1722.3196837249216, 1072.9967480405846, 1078.9190810689072, 1090.4275255490932, 1095.1731442760665, 1095.5453486803046, 6832.385085342343, 6873.931260687429, 6888.483363747739, 6892.414144797748, 6895.207051189177, 7708.961455192688, 7709.151993280735, 7737.381009519225, 7739.020477116238, 7741.032370953631, 5163.3545806774155, 5938.287405511366, 6658.533902626769, 6841.144856892888, 6968.338007889242, 3471.2710330830305, 3962.2075584883137, 4050.25070361984, 4089.7750623715983, 4138.296489596776, 6842.863142737117, 7334.716424625669, 7763.72826951054, 7892.408069394818, 8178.918210817816, 8048.0, 8060.0, 8081.111077781439, 8097.595120244082, 8105.594720263964, 7954.403419743542, 8185.71350002747, 8194.918050819535, 8196.5491897945, 8210.137935516685, 7834.921650783419, 7837.568933708472, 7847.529148251123, 7857.9214207857185, 7899.605019748875, 7456.254374562501, 7677.654505547152, 7680.5391676499585, 7694.07671079474, 7730.961345193238, 6595.472362210916, 6948.305169483011, 7806.687732490636, 8152.83694326122, 8191.262786349257, 4836.274558816206, 4881.219004959332, 4881.877953051202, 4888.193448081027, 4893.314935909047, 7601.353884919844, 7787.0, 7811.453198276066, 7828.373730101464, 7843.333316668147, 7500.0, 7523.0, 7531.623418828927, 7535.585542795199, 7536.5101268417375, 7338.926610734038, 7502.324790768639, 7504.849903002018, 7505.66224519887, 7521.323080922743, 5954.7320370582565, 7318.121825380776, 7318.926810731825, 7332.30343117403, 7353.963230183815, 7502.737404190827, 7522.774316770506, 7523.88714169277, 7542.962285188539, 7557.2820582044615, 7113.324234197743, 7341.963290183515, 7352.411807055316, 7378.889316660362, 7391.852162956819], "unit": "score", "name": "prototype.html", "value": 5372.4428473076905}, {"lowerIsBetter": false, "replicates": [675.4630069095069, 716.5056111283216, 721.9494635375522, 722.1154086244348, 730.0728075344313, 14824.481143159992, 14991.775123373158, 15066.09603423794, 15092.471763488253, 15140.77288840667, 13725.862741372583, 13736.175829450214, 14002.649933751662, 14050.929745351259, 14060.859391406082, 700.271717413889, 719.2663483247085, 849.3247867944998, 854.8076682746379, 866.2160744526183, 859.1966511311912, 868.4615538366222, 868.956552172392, 870.9766024920724, 870.9782255443633, 879.8548239540468, 908.3959167153835, 914.6295750221171, 915.2037727177365, 935.0602644342426, 885.6944354197856, 897.7172190759923, 899.0021076604963, 908.4821651658524, 908.6183802802839, 639.7217210513442, 651.9119918810948, 658.5061204096927, 666.4135560706595, 666.4401902401958, 14434.13395196281, 14505.41978320866, 14634.0, 14642.926785366006, 14699.779503307458, 9723.0, 12290.877091229062, 12328.75342493145, 12378.504859805687, 12405.193662411913, 8157.388195885333, 8385.329173666092, 10078.344907580984, 10097.293189476739, 10185.18518518524, 3331.034000139981, 3387.1870751019824, 3464.3764122457947, 3512.385332566816, 3527.8059706716376, 72461.63769181121, 73254.16864578429, 73519.89720154201, 80544.79182812263, 80694.386112278, 7747.535147891144, 7884.881726774103, 8651.264642505457, 9511.714648560554, 9689.27330450205, 20432.795672043387, 20435.693464598044, 20452.48868778263, 20457.18171273162, 20487.487812804502, 7423.740169094056, 7605.391568674493, 7629.771106866803, 7800.45396822217, 7836.960815195887, 4080.8979775505254, 4122.546519882811, 4157.376393540932, 4200.201961627281, 4226.021833455484, 3578.8926332210076, 3598.2803439312243, 3609.8556057757396, 3630.7276954228537, 3632.636736326346, 678.6131904814307, 682.9829254268584, 692.1452006771633, 701.740356068258, 702.9367356937901, 530.4933788232229, 552.1496894781991, 594.6045879490091, 614.8370681769335, 621.7606221604624, 9037.502937338379, 9219.709240706306, 9232.446053236694, 9286.0, 9313.0, 499.03187815638273, 503.41855157293384, 571.8541771848152, 614.6680792372069, 636.5448704176536, 3972.841086356513, 3996.720229583901, 4077.7145599808323, 4098.057446787196, 4106.0, 78288.82566761503, 78445.82331265036, 79152.60423697844, 79261.20738792654, 79275.20724792793, 74513.0, 74592.0, 74989.62505187439, 75399.0, 76392.61803690947, 64468.67765661235, 64951.02573461402, 66795.0, 66949.0, 67656.0, 8035.0, 8105.918940810517, 8232.259096681328, 8265.297449716842, 8267.83464330698, 44446.555534445535, 46106.538934610224, 46271.537284628066, 46659.53340466552, 46758.59724208279, 57546.0, 63345.29892309714, 63424.68287658532, 64091.0, 64350.35649643631, 9830.901690982999, 9876.753081173028, 9902.257330700082, 9970.0, 10312.639057632947, 10739.409332486788, 10755.247132700948, 10805.891941080488, 11327.773444530898, 11623.5350585979, 10638.627648032281, 10645.574177032831, 10649.787004260026, 10737.355758654505, 10785.568577256821, 10560.471976400995, 10638.042576168182, 10647.0, 10774.892251077703, 10804.24370294072, 10279.126274266471, 10332.845007324746, 10373.170146388422, 10394.948025259826, 10477.895221047693, 8403.478122766597, 8494.277986371228, 8686.78283042929, 8745.344099192713, 8779.165979231962, 8829.984551776628, 8913.55432228373, 8956.328275379243, 9120.0, 9158.58786354629], "unit": "score", "name": "yui.html", "value": 6635.870608098012}], "name": "dromaeo_css", "value": 7536.766109542788}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 106.0, 114.0, 113.0, 116.0, 125.0, 114.0, 115.0, 118.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [154.0, 106.0, 171.0, 179.0, 154.0, 139.0, 141.0, 123.0, 194.0, 154.0], "unit": "score", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [272.0, 271.0, 200.0, 256.0, 231.0, 277.0, 193.0, 282.0, 287.0, 200.0], "unit": "score", "name": "audio-dft", "value": 246.9}, {"lowerIsBetter": true, "replicates": [81.0, 70.0, 72.0, 125.0, 53.0, 75.0, 90.0, 86.0, 101.0, 55.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [80.0, 90.0, 114.0, 77.0, 79.0, 83.0, 113.0, 80.0, 83.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 91.0}, {"lowerIsBetter": true, "replicates": [104.0, 95.0, 88.0, 95.0, 88.0, 93.0, 88.0, 95.0, 109.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.9}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 98.0, 96.0, 99.0, 98.0, 98.0, 98.0, 97.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 97.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 89.0, 92.0, 94.0, 94.0, 90.0, 91.0, 91.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 91.9}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 55.0, 56.0, 55.0, 57.0, 53.0, 63.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 71.0, 64.0, 87.0, 71.0, 66.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 86.0, 86.0, 86.0, 83.0, 88.0, 86.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [122.0, 133.0, 130.0, 143.0, 138.0, 114.0, 122.0, 129.0, 137.0, 141.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.9}, {"lowerIsBetter": true, "replicates": [140.0, 143.0, 139.0, 136.0, 141.0, 143.0, 143.0, 139.0, 139.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.1}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 66.0, 69.0, 70.0, 73.0, 84.0, 99.0, 98.0, 78.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.1}], "name": "kraken", "value": 1528.0999999999997}]} 00:16:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1528.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7536.77"}}} 00:16:31 INFO - Return code: 0 00:16:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:16:31 INFO - # TBPL SUCCESS # 00:16:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:16:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:16:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:16:31 INFO - 2016-01-31 00:16:31.458 screenresolution[1704:17422] starting screenresolution argv=screenresolution get 00:16:31 INFO - 2016-01-31 00:16:31.460 screenresolution[1704:17422] Display 0: 1600x1200x32@60 00:16:31 INFO - 2016-01-31 00:16:31.466 screenresolution[1705:17425] starting screenresolution argv=screenresolution list 00:16:31 INFO - Available Modes on Display 0 00:16:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:16:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:16:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:16:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:16:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:16:31 INFO - Intel Iris: 00:16:31 INFO - Chipset Model: Intel Iris 00:16:31 INFO - Type: GPU 00:16:31 INFO - Bus: Built-In 00:16:31 INFO - VRAM (Dynamic, Max): 1536 MB 00:16:31 INFO - Vendor: Intel (0x8086) 00:16:31 INFO - Device ID: 0x0a2e 00:16:31 INFO - Revision ID: 0x0009 00:16:31 INFO - Displays: 00:16:31 INFO - Display: 00:16:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:16:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:16:31 INFO - Display Serial Number: 1600x1200 60 00:16:31 INFO - Main Display: Yes 00:16:31 INFO - Mirror: Off 00:16:31 INFO - Online: Yes 00:16:31 INFO - Rotation: Supported 00:16:31 INFO - Return code: 0 00:16:31 INFO - Running post-action listener: _resource_record_post_action 00:16:31 INFO - Running post-run listener: _resource_record_post_run 00:16:32 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 35618304; Write bytes: 711886848; Read time: 405; Write time: 2367 00:16:32 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399331840; Write bytes: 393091072; Read time: 30094; Write time: 665 00:16:32 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 33836544; Write bytes: 305192960; Read time: 387; Write time: 1666 00:16:32 INFO - Running post-run listener: _upload_blobber_files 00:16:32 INFO - Blob upload gear active. 00:16:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:16:32 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:16:32 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:16:32 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:16:33 INFO - (blobuploader) - INFO - Open directory for files ... 00:16:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:16:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:16:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:16:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:16:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:16:34 INFO - (blobuploader) - INFO - Done attempting. 00:16:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:16:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:16:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:16:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:16:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:16:35 INFO - (blobuploader) - INFO - Done attempting. 00:16:35 INFO - (blobuploader) - INFO - Iteration through files over. 00:16:35 INFO - Return code: 0 00:16:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:16:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:16:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/722ca8d02cc2bb37ec7fa7d064d7ec6492523b6d807c4b41746610abd9595d341a54a66d58870f9b8df0b21705367c67e8dc3a3a7cfab6e21eef57d3696367f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/662a7b48b13506a68af21b051d9f848cf1920953c12fbfdab646b9addc4998a86f2cece098386f2996749a12f071ac8c9248147d7b3de8be0ac508135cff36e3"} 00:16:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:16:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:16:35 INFO - Contents: 00:16:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/722ca8d02cc2bb37ec7fa7d064d7ec6492523b6d807c4b41746610abd9595d341a54a66d58870f9b8df0b21705367c67e8dc3a3a7cfab6e21eef57d3696367f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/662a7b48b13506a68af21b051d9f848cf1920953c12fbfdab646b9addc4998a86f2cece098386f2996749a12f071ac8c9248147d7b3de8be0ac508135cff36e3"} 00:16:35 INFO - Running post-run listener: copy_logs_to_upload_dir 00:16:35 INFO - Copying logs to upload dir... 00:16:35 INFO - mkdir: /builds/slave/test/build/upload/logs 00:16:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.599711 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-31 00:16:35.795010) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-31 00:16:35.798140) ========= 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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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/722ca8d02cc2bb37ec7fa7d064d7ec6492523b6d807c4b41746610abd9595d341a54a66d58870f9b8df0b21705367c67e8dc3a3a7cfab6e21eef57d3696367f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/662a7b48b13506a68af21b051d9f848cf1920953c12fbfdab646b9addc4998a86f2cece098386f2996749a12f071ac8c9248147d7b3de8be0ac508135cff36e3"} build_url:https://queue.taskcluster.net/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/Kl63NpCdRzKadOWYVYlMvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/722ca8d02cc2bb37ec7fa7d064d7ec6492523b6d807c4b41746610abd9595d341a54a66d58870f9b8df0b21705367c67e8dc3a3a7cfab6e21eef57d3696367f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/662a7b48b13506a68af21b051d9f848cf1920953c12fbfdab646b9addc4998a86f2cece098386f2996749a12f071ac8c9248147d7b3de8be0ac508135cff36e3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-31 00:16:35.824260) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 00:16:35.824554) ========= 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.9yJjO7jFmq/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.JlRhGtj3i1/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005261 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 00:16:35.872874) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-31 00:16:35.873182) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-31 00:16:35.873578) ========= ========= Total master_lag: 0.65 =========