builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0018 starttime: 1458969465.05 results: success (0) buildid: 20160325194939 builduid: 7a7992b726704185bf579407b1b1724a revision: 5579b62017f217581e1d414f801166c7d55d4f4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:45.058655) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:45.059065) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:45.059434) ========= 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.uho8VYpNB6/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.blMYX1R446/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.005613 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:45.087374) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:45.087659) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:46.084743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:46.085162) ========= 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.uho8VYpNB6/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.blMYX1R446/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.005756 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:46.133587) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:46.133907) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:46.134262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:46.134535) ========= 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.uho8VYpNB6/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.blMYX1R446/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-25 22:17:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 30.7M=0s 2016-03-25 22:17:46 (30.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107356 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:46.446066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:46.446464) ========= 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.uho8VYpNB6/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.blMYX1R446/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.026670 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:46.583648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-25 22:17:46.584007) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5579b62017f217581e1d414f801166c7d55d4f4c --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 5579b62017f217581e1d414f801166c7d55d4f4c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uho8VYpNB6/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.blMYX1R446/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-25 22:17:46,631 truncating revision to first 12 chars 2016-03-25 22:17:46,631 Setting DEBUG logging. 2016-03-25 22:17:46,631 attempt 1/10 2016-03-25 22:17:46,631 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5579b62017f2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 22:17:47,741 unpacking tar archive at: fx-team-5579b62017f2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.350036 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-25 22:17:47.948788) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:47.949118) ========= echo 5579b62017f217581e1d414f801166c7d55d4f4c in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5579b62017f217581e1d414f801166c7d55d4f4c'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uho8VYpNB6/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.blMYX1R446/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 5579b62017f217581e1d414f801166c7d55d4f4c program finished with exit code 0 elapsedTime=0.005008 script_repo_revision: '5579b62017f217581e1d414f801166c7d55d4f4c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:48.001825) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:48.002331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 22:17:48.015568) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2016-03-25 22:17:48.015873) ========= /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.uho8VYpNB6/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.blMYX1R446/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 22:17:48 INFO - MultiFileLogger online at 20160325 22:17:48 in /builds/slave/test 22:17:48 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 22:17:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:17:48 INFO - {'append_to_log': False, 22:17:48 INFO - 'base_work_dir': '/builds/slave/test', 22:17:48 INFO - 'blob_upload_branch': 'Fx-Team', 22:17:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:17:48 INFO - 'branch': 'Fx-Team', 22:17:48 INFO - 'buildbot_json_path': 'buildprops.json', 22:17:48 INFO - 'config_files': ('talos/mac_config.py',), 22:17:48 INFO - 'default_actions': ('clobber', 22:17:48 INFO - 'read-buildbot-config', 22:17:48 INFO - 'download-and-extract', 22:17:48 INFO - 'populate-webroot', 22:17:48 INFO - 'create-virtualenv', 22:17:48 INFO - 'install', 22:17:48 INFO - 'run-tests'), 22:17:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:17:48 INFO - 'download_minidump_stackwalk': True, 22:17:48 INFO - 'download_symbols': 'ondemand', 22:17:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:17:48 INFO - 'tooltool.py': '/tools/tooltool.py', 22:17:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:17:48 INFO - '/tools/misc-python/virtualenv.py')}, 22:17:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:17:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:17:48 INFO - 'installer_path': 'installer.exe', 22:17:48 INFO - 'log_level': 'info', 22:17:48 INFO - 'log_name': 'talos', 22:17:48 INFO - 'log_to_console': True, 22:17:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:17:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:17:48 INFO - 'opt_config_files': (), 22:17:48 INFO - 'pip_index': False, 22:17:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:17:48 INFO - 'cmd': ('bash', 22:17:48 INFO - '-c', 22:17:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:17:48 INFO - 'enabled': True, 22:17:48 INFO - 'halt_on_failure': False, 22:17:48 INFO - 'name': 'check_screen_resolution'},), 22:17:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:17:48 INFO - 'cmd': ('bash', 22:17:48 INFO - '-c', 22:17:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:17:48 INFO - 'enabled': True, 22:17:48 INFO - 'halt_on_failure': False, 22:17:48 INFO - 'name': 'check_screen_resolution'},), 22:17:48 INFO - 'run_cmd_checks_enabled': True, 22:17:48 INFO - 'sps_profile': False, 22:17:48 INFO - 'sps_profile_interval': 0, 22:17:48 INFO - 'suite': 'dromaeojs-e10s', 22:17:48 INFO - 'system_bits': '32', 22:17:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:17:48 INFO - 'title': 't-yosemite-r7-0018', 22:17:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:17:48 INFO - 'use_talos_json': True, 22:17:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:17:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:17:48 INFO - 'work_dir': 'build'} 22:17:48 INFO - ##### 22:17:48 INFO - ##### Running clobber step. 22:17:48 INFO - ##### 22:17:48 INFO - Running pre-action listener: _resource_record_pre_action 22:17:48 INFO - Running main action method: clobber 22:17:48 INFO - rmtree: /builds/slave/test/build 22:17:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:17:49 INFO - Running post-action listener: _resource_record_post_action 22:17:49 INFO - ##### 22:17:49 INFO - ##### Running read-buildbot-config step. 22:17:49 INFO - ##### 22:17:49 INFO - Running pre-action listener: _resource_record_pre_action 22:17:49 INFO - Running main action method: read_buildbot_config 22:17:49 INFO - Using buildbot properties: 22:17:49 INFO - { 22:17:49 INFO - "project": "", 22:17:49 INFO - "product": "firefox", 22:17:49 INFO - "script_repo_revision": "production", 22:17:49 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 22:17:49 INFO - "repository": "", 22:17:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 22:17:49 INFO - "buildid": "20160325194939", 22:17:49 INFO - "pgo_build": "False", 22:17:49 INFO - "basedir": "/builds/slave/test", 22:17:49 INFO - "buildnumber": 543, 22:17:49 INFO - "slavename": "t-yosemite-r7-0018", 22:17:49 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 22:17:49 INFO - "platform": "yosemite_r7", 22:17:49 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 22:17:49 INFO - "branch": "fx-team", 22:17:49 INFO - "repo_path": "integration/fx-team", 22:17:49 INFO - "revision": "5579b62017f217581e1d414f801166c7d55d4f4c", 22:17:49 INFO - "stage_platform": "macosx64", 22:17:49 INFO - "builduid": "7a7992b726704185bf579407b1b1724a", 22:17:49 INFO - "slavebuilddir": "test" 22:17:49 INFO - } 22:17:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 22:17:49 INFO - Running post-action listener: _resource_record_post_action 22:17:49 INFO - ##### 22:17:49 INFO - ##### Running download-and-extract step. 22:17:49 INFO - ##### 22:17:49 INFO - Running pre-action listener: _resource_record_pre_action 22:17:49 INFO - Running main action method: download_and_extract 22:17:49 INFO - mkdir: /builds/slave/test/build/tests 22:17:49 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')]} 22:17:49 INFO - https://queue.taskcluster.net/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 22:17:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 22:17:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 22:17:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 22:17:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 22:18:01 INFO - Downloaded 1199 bytes. 22:18:01 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 22:18:01 INFO - Using the following test package requirements: 22:18:01 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 22:18:01 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:18:01 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 22:18:01 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:18:01 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 22:18:01 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:18:01 INFO - u'jsshell-mac.zip'], 22:18:01 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:18:01 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 22:18:01 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 22:18:01 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:18:01 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 22:18:01 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:18:01 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 22:18:01 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:18:01 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 22:18:01 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:18:01 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 22:18:01 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:18:01 INFO - https://queue.taskcluster.net/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:18:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:18:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:18:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:18:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:18:11 INFO - Downloaded 17943896 bytes. 22:18:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:18:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:18:14 INFO - Return code: 0 22:18:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:18:14 INFO - https://queue.taskcluster.net/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:18:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:18:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:18:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:18:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:18:27 INFO - Downloaded 17943896 bytes. 22:18:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:18:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:18:31 INFO - Return code: 0 22:18:31 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')]} 22:18:31 INFO - https://queue.taskcluster.net/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:18:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:18:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:18:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:18:32 INFO - Downloaded 10847531 bytes. 22:18:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:18:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 22:18:33 INFO - Return code: 0 22:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:18:33 INFO - https://queue.taskcluster.net/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:18:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:18:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:18:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 22:18:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 22:18:49 INFO - Downloaded 111385226 bytes. 22:18:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:18:49 INFO - mkdir: /builds/slave/test/properties 22:18:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:18:49 INFO - Writing to file /builds/slave/test/properties/build_url 22:18:49 INFO - Contents: 22:18:49 INFO - build_url:https://queue.taskcluster.net/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:18:50 INFO - Running post-action listener: _resource_record_post_action 22:18:50 INFO - Running post-action listener: set_extra_try_arguments 22:18:50 INFO - ##### 22:18:50 INFO - ##### Running populate-webroot step. 22:18:50 INFO - ##### 22:18:50 INFO - Running pre-action listener: _resource_record_pre_action 22:18:50 INFO - Running main action method: populate_webroot 22:18:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:18:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:18:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:18:50 INFO - '--tppagecycles', 22:18:50 INFO - '7'], 22:18:50 INFO - 'tests': ['tsvgm']}}, 22:18:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:18:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:18:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:18:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:18:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:18:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:18:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:18:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:50 INFO - 'talos_options': ['--e10s'], 22:18:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:18:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:50 INFO - 'tests': ['damp', 'tps']}, 22:18:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:50 INFO - 'talos_options': ['--e10s'], 22:18:50 INFO - 'tests': ['damp', 'tps']}, 22:18:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:18:50 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 22:18:50 INFO - 'tests': ['dromaeo_dom']}, 22:18:50 INFO - 'other': {'tests': ['a11yr', 22:18:50 INFO - 'ts_paint', 22:18:50 INFO - 'tpaint', 22:18:50 INFO - 'sessionrestore', 22:18:50 INFO - 'sessionrestore_no_auto_restore', 22:18:50 INFO - 'tabpaint']}, 22:18:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:18:50 INFO - 'tests': ['a11yr', 22:18:50 INFO - 'ts_paint', 22:18:50 INFO - 'tpaint', 22:18:50 INFO - 'sessionrestore', 22:18:50 INFO - 'sessionrestore_no_auto_restore', 22:18:50 INFO - 'tabpaint']}, 22:18:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:18:50 INFO - 'tests': ['a11yr', 22:18:50 INFO - 'ts_paint', 22:18:50 INFO - 'tpaint', 22:18:50 INFO - 'sessionrestore', 22:18:50 INFO - 'sessionrestore_no_auto_restore', 22:18:50 INFO - 'tabpaint']}, 22:18:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:18:50 INFO - 'tests': ['a11yr', 22:18:50 INFO - 'ts_paint', 22:18:50 INFO - 'tpaint', 22:18:50 INFO - 'sessionrestore', 22:18:50 INFO - 'sessionrestore_no_auto_restore', 22:18:50 INFO - 'tabpaint']}, 22:18:50 INFO - 'other_l64': {'tests': ['a11yr', 22:18:50 INFO - 'ts_paint', 22:18:50 INFO - 'tpaint', 22:18:50 INFO - 'sessionrestore', 22:18:50 INFO - 'sessionrestore_no_auto_restore', 22:18:50 INFO - 'tabpaint']}, 22:18:50 INFO - 'other_nol64': {'tests': ['a11yr', 22:18:50 INFO - 'ts_paint', 22:18:50 INFO - 'tpaint', 22:18:50 INFO - 'sessionrestore', 22:18:50 INFO - 'sessionrestore_no_auto_restore', 22:18:50 INFO - 'tabpaint']}, 22:18:50 INFO - 'svgr': {'tests': ['tsvgx', 22:18:50 INFO - 'tsvgr_opacity', 22:18:50 INFO - 'tart', 22:18:50 INFO - 'tscrollx', 22:18:50 INFO - 'cart']}, 22:18:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:18:50 INFO - 'tests': ['tsvgx', 22:18:50 INFO - 'tsvgr_opacity', 22:18:50 INFO - 'tart', 22:18:50 INFO - 'tscrollx', 22:18:50 INFO - 'cart']}, 22:18:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:50 INFO - 'tests': ['tp5o']}, 22:18:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:50 INFO - 'talos_options': ['--e10s'], 22:18:50 INFO - 'tests': ['tp5o']}, 22:18:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:50 INFO - 'talos_options': ['--xperf_path', 22:18:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:18:50 INFO - 'tests': ['tp5n']}, 22:18:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:50 INFO - 'talos_options': ['--e10s', 22:18:50 INFO - '--xperf_path', 22:18:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:18:50 INFO - 'tests': ['tp5n']}}, 22:18:50 INFO - 'talos.zip': {'path': '', 22:18:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:18:50 INFO - Running post-action listener: _resource_record_post_action 22:18:50 INFO - ##### 22:18:50 INFO - ##### Running create-virtualenv step. 22:18:50 INFO - ##### 22:18:50 INFO - Running pre-action listener: _resource_record_pre_action 22:18:50 INFO - Running main action method: create_virtualenv 22:18:50 INFO - Creating virtualenv /builds/slave/test/build/venv 22:18: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 22:18:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:18:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:18:50 INFO - Using real prefix '/tools/python27' 22:18:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:18:51 INFO - Installing distribute.............................................................................................................................................................................................done. 22:18:54 INFO - Installing pip.................done. 22:18:54 INFO - Return code: 0 22:18:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:18: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')]} 22:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18: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')]} 22:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18: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 0x1024fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bcbf8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10239ae00>, '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 0x102203db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395b20>, '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.uho8VYpNB6/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.blMYX1R446/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 22:18: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 22:18: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 22:18:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uho8VYpNB6/Render', 22:18:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:18:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:18:54 INFO - 'HOME': '/Users/cltbld', 22:18:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:18:54 INFO - 'LOGNAME': 'cltbld', 22:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:18:54 INFO - 'MOZ_NO_REMOTE': '1', 22:18:54 INFO - 'NO_EM_RESTART': '1', 22:18:54 INFO - 'PAGER': '/bin/cat', 22:18:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:18:54 INFO - 'PWD': '/builds/slave/test', 22:18:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:18:54 INFO - 'SHELL': '/bin/bash', 22:18:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.blMYX1R446/Listeners', 22:18:54 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 22:18:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:18:54 INFO - 'USER': 'cltbld', 22:18:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:18:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:18:54 INFO - 'XPC_FLAGS': '0x0', 22:18:54 INFO - 'XPC_SERVICE_NAME': '0', 22:18:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:18: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 22:18:54 INFO - Cleaning up... 22:18:54 INFO - Return code: 0 22:18:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:18: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')]} 22:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18: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')]} 22:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18: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 0x1024fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bcbf8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10239ae00>, '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 0x102203db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395b20>, '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.uho8VYpNB6/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.blMYX1R446/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 22:18: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 22:18: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 22:18:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uho8VYpNB6/Render', 22:18:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:18:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:18:54 INFO - 'HOME': '/Users/cltbld', 22:18:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:18:54 INFO - 'LOGNAME': 'cltbld', 22:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:18:54 INFO - 'MOZ_NO_REMOTE': '1', 22:18:54 INFO - 'NO_EM_RESTART': '1', 22:18:54 INFO - 'PAGER': '/bin/cat', 22:18:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:18:54 INFO - 'PWD': '/builds/slave/test', 22:18:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:18:54 INFO - 'SHELL': '/bin/bash', 22:18:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.blMYX1R446/Listeners', 22:18:54 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 22:18:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:18:54 INFO - 'USER': 'cltbld', 22:18:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:18:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:18:54 INFO - 'XPC_FLAGS': '0x0', 22:18:54 INFO - 'XPC_SERVICE_NAME': '0', 22:18:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:18:54 INFO - Downloading/unpacking psutil>=0.7.1 22:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:18:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:18:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:18:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:18:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:18:57 INFO - Installing collected packages: psutil 22:18:57 INFO - Running setup.py install for psutil 22:18:58 INFO - building 'psutil._psutil_osx' extension 22:18: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 22:18: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 22:18: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 22:18:58 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 22:18:58 INFO - building 'psutil._psutil_posix' extension 22:18:58 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 22:18:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:18:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:18:59 INFO - ^ 22:18:59 INFO - 1 warning generated. 22:18: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 22:18:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:18:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:18:59 INFO - Successfully installed psutil 22:18:59 INFO - Cleaning up... 22:18:59 INFO - Return code: 0 22:18:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:18: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')]} 22:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18: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')]} 22:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18: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 0x1024fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bcbf8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10239ae00>, '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 0x102203db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395b20>, '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.uho8VYpNB6/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.blMYX1R446/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 22:18: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 22:18: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 22:18:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uho8VYpNB6/Render', 22:18:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:18:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:18:59 INFO - 'HOME': '/Users/cltbld', 22:18:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:18:59 INFO - 'LOGNAME': 'cltbld', 22:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:18:59 INFO - 'MOZ_NO_REMOTE': '1', 22:18:59 INFO - 'NO_EM_RESTART': '1', 22:18:59 INFO - 'PAGER': '/bin/cat', 22:18:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:18:59 INFO - 'PWD': '/builds/slave/test', 22:18:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:18:59 INFO - 'SHELL': '/bin/bash', 22:18:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.blMYX1R446/Listeners', 22:18:59 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 22:18:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:18:59 INFO - 'USER': 'cltbld', 22:18:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:18:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:18:59 INFO - 'XPC_FLAGS': '0x0', 22:18:59 INFO - 'XPC_SERVICE_NAME': '0', 22:18:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:18:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:18:59 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 22:18:59 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 22:18:59 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 22:18:59 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 22:18:59 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 22:18:59 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 22:19:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:19:01 INFO - Installing collected packages: mozsystemmonitor 22:19:01 INFO - Running setup.py install for mozsystemmonitor 22:19:02 INFO - Successfully installed mozsystemmonitor 22:19:02 INFO - Cleaning up... 22:19:02 INFO - Return code: 0 22:19:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:19: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')]} 22:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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')]} 22:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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 0x1024fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bcbf8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10239ae00>, '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 0x102203db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395b20>, '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.uho8VYpNB6/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.blMYX1R446/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 22:19: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 22:19: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 22:19:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uho8VYpNB6/Render', 22:19:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:19:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:19:02 INFO - 'HOME': '/Users/cltbld', 22:19:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:19:02 INFO - 'LOGNAME': 'cltbld', 22:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:02 INFO - 'MOZ_NO_REMOTE': '1', 22:19:02 INFO - 'NO_EM_RESTART': '1', 22:19:02 INFO - 'PAGER': '/bin/cat', 22:19:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:02 INFO - 'PWD': '/builds/slave/test', 22:19:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:19:02 INFO - 'SHELL': '/bin/bash', 22:19:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.blMYX1R446/Listeners', 22:19:02 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 22:19:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:19:02 INFO - 'USER': 'cltbld', 22:19:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:19:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:02 INFO - 'XPC_FLAGS': '0x0', 22:19:02 INFO - 'XPC_SERVICE_NAME': '0', 22:19:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:02 INFO - Downloading/unpacking blobuploader==1.2.4 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19:04 INFO - Downloading blobuploader-1.2.4.tar.gz 22:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:19:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:19:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19:05 INFO - Downloading docopt-0.6.1.tar.gz 22:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:19:06 INFO - Installing collected packages: blobuploader, requests, docopt 22:19:06 INFO - Running setup.py install for blobuploader 22:19:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:19:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:19:06 INFO - Running setup.py install for requests 22:19:06 INFO - Running setup.py install for docopt 22:19:06 INFO - Successfully installed blobuploader requests docopt 22:19:06 INFO - Cleaning up... 22:19:06 INFO - Return code: 0 22:19:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:06 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')]} 22:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:06 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')]} 22:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:06 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 0x1024fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bcbf8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10239ae00>, '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 0x102203db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395b20>, '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.uho8VYpNB6/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.blMYX1R446/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 22:19:06 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 22:19:06 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 22:19:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uho8VYpNB6/Render', 22:19:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:19:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:19:06 INFO - 'HOME': '/Users/cltbld', 22:19:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:19:06 INFO - 'LOGNAME': 'cltbld', 22:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:06 INFO - 'MOZ_NO_REMOTE': '1', 22:19:06 INFO - 'NO_EM_RESTART': '1', 22:19:06 INFO - 'PAGER': '/bin/cat', 22:19:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:06 INFO - 'PWD': '/builds/slave/test', 22:19:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:19:06 INFO - 'SHELL': '/bin/bash', 22:19:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.blMYX1R446/Listeners', 22:19:06 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 22:19:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:19:06 INFO - 'USER': 'cltbld', 22:19:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:19:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:06 INFO - 'XPC_FLAGS': '0x0', 22:19:06 INFO - 'XPC_SERVICE_NAME': '0', 22:19:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:19:07 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-dHaWXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:19:07 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-_1P8vR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:19:07 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-J8KdI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:19:07 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-o6cp4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:19:07 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-urIKKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:19:07 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-y93qP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:19:07 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-RsdwD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:19:07 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-I9ymOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:19:08 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-aaHxMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:19:08 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-PWaBYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:19:08 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-FKDCY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:19:08 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-GDg91s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:19:08 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-uv_ktn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:19:08 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-S05V96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:08 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-OgqLv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:19:08 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-idz8ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:19:08 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-wZZBep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:19:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:19:08 INFO - Running setup.py install for manifestparser 22:19:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:19:09 INFO - Running setup.py install for mozcrash 22:19:09 INFO - Running setup.py install for mozdebug 22:19:09 INFO - Running setup.py install for mozdevice 22:19:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:19:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:19:09 INFO - Running setup.py install for mozfile 22:19:09 INFO - Running setup.py install for mozhttpd 22:19:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:19:09 INFO - Running setup.py install for mozinfo 22:19:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:19:09 INFO - Running setup.py install for mozInstall 22:19:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:19:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:19:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:19:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:19:10 INFO - Running setup.py install for mozleak 22:19:10 INFO - Running setup.py install for mozlog 22:19:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:19:10 INFO - Running setup.py install for moznetwork 22:19:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:19:10 INFO - Running setup.py install for mozprocess 22:19:10 INFO - Running setup.py install for mozprofile 22:19:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:19:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:19:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:19:10 INFO - Running setup.py install for mozrunner 22:19:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:19:11 INFO - Running setup.py install for mozscreenshot 22:19:11 INFO - Running setup.py install for moztest 22:19:11 INFO - Running setup.py install for mozversion 22:19:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:19:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:19:11 INFO - Cleaning up... 22:19:11 INFO - Return code: 0 22:19:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19: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')]} 22:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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')]} 22:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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 0x1024fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bcbf8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10239ae00>, '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 0x102203db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395b20>, '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.uho8VYpNB6/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.blMYX1R446/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 22:19: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 22:19: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 22:19:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uho8VYpNB6/Render', 22:19:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:19:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:19:11 INFO - 'HOME': '/Users/cltbld', 22:19:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:19:11 INFO - 'LOGNAME': 'cltbld', 22:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:11 INFO - 'MOZ_NO_REMOTE': '1', 22:19:11 INFO - 'NO_EM_RESTART': '1', 22:19:11 INFO - 'PAGER': '/bin/cat', 22:19:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:11 INFO - 'PWD': '/builds/slave/test', 22:19:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:19:11 INFO - 'SHELL': '/bin/bash', 22:19:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.blMYX1R446/Listeners', 22:19:11 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 22:19:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:19:11 INFO - 'USER': 'cltbld', 22:19:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:19:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:11 INFO - 'XPC_FLAGS': '0x0', 22:19:11 INFO - 'XPC_SERVICE_NAME': '0', 22:19:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:19:11 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-2XQrFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:19:11 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)) 22:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:19:11 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-AFzUG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:19:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:19:12 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-dPrq2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:19: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)) 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:19:12 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-aMbUfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:19: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)) 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:19:12 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-EecD3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:19: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)) 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:19:12 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-m2gek7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:19: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)) 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:19:12 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-iV3HDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:19: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)) 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:19:12 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Z1MJLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:19: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)) 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:19:12 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-3LiBLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:19: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)) 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:19:12 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-bt_KSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:19: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)) 22:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:19:12 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-k3TbO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:19: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)) 22:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:19:13 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Zg0Of7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:19: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)) 22:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:19:13 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-LMPGzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:19: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)) 22:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:19:13 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-CgeSay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:19: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)) 22:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:13 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-z60VR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:19: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)) 22:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:19:13 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-PrQzq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:19: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)) 22:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:19:13 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-HkcvwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:19: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)) 22:19: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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19: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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19: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)) 22:19: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)) 22:19: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)) 22:19:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19:15 INFO - Downloading blessings-1.6.tar.gz 22:19:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:19:16 INFO - Installing collected packages: blessings 22:19:16 INFO - Running setup.py install for blessings 22:19:16 INFO - Successfully installed blessings 22:19:16 INFO - Cleaning up... 22:19:16 INFO - Return code: 0 22:19:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:19:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:19:16 INFO - Reading from file tmpfile_stdout 22:19:16 INFO - Current package versions: 22:19:16 INFO - blessings == 1.6 22:19:16 INFO - blobuploader == 1.2.4 22:19:16 INFO - docopt == 0.6.1 22:19:16 INFO - manifestparser == 1.1 22:19:16 INFO - mozInstall == 1.12 22:19:16 INFO - mozcrash == 0.17 22:19:16 INFO - mozdebug == 0.1 22:19:16 INFO - mozdevice == 0.48 22:19:16 INFO - mozfile == 1.2 22:19:16 INFO - mozhttpd == 0.7 22:19:16 INFO - mozinfo == 0.9 22:19:16 INFO - mozleak == 0.1 22:19:16 INFO - mozlog == 3.1 22:19:16 INFO - moznetwork == 0.27 22:19:16 INFO - mozprocess == 0.22 22:19:16 INFO - mozprofile == 0.28 22:19:16 INFO - mozrunner == 6.11 22:19:16 INFO - mozscreenshot == 0.1 22:19:16 INFO - mozsystemmonitor == 0.0 22:19:16 INFO - moztest == 0.7 22:19:16 INFO - mozversion == 1.4 22:19:16 INFO - psutil == 3.1.1 22:19:16 INFO - requests == 1.2.3 22:19:16 INFO - wsgiref == 0.1.2 22:19:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19: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')]} 22:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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')]} 22:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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 0x1024fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bcbf8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10239ae00>, '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 0x102203db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395b20>, '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.uho8VYpNB6/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.blMYX1R446/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 22:19: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 22:19: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 22:19:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uho8VYpNB6/Render', 22:19:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:19:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:19:16 INFO - 'HOME': '/Users/cltbld', 22:19:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:19:16 INFO - 'LOGNAME': 'cltbld', 22:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:16 INFO - 'MOZ_NO_REMOTE': '1', 22:19:16 INFO - 'NO_EM_RESTART': '1', 22:19:16 INFO - 'PAGER': '/bin/cat', 22:19:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:16 INFO - 'PWD': '/builds/slave/test', 22:19:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:19:16 INFO - 'SHELL': '/bin/bash', 22:19:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.blMYX1R446/Listeners', 22:19:16 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 22:19:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:19:16 INFO - 'USER': 'cltbld', 22:19:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:19:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:16 INFO - 'XPC_FLAGS': '0x0', 22:19:16 INFO - 'XPC_SERVICE_NAME': '0', 22:19:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19: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)) 22:19: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)) 22:19: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)) 22:19: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)) 22:19: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)) 22:19: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)) 22:19: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)) 22:19: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)) 22:19: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)) 22:19: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)) 22:19: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)) 22:19:16 INFO - Cleaning up... 22:19:16 INFO - Return code: 0 22:19:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:19: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')]} 22:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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')]} 22:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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 0x1024fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bcbf8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10239ae00>, '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 0x102203db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395b20>, '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.uho8VYpNB6/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.blMYX1R446/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 22:19: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 22:19: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 22:19:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uho8VYpNB6/Render', 22:19:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:19:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:19:16 INFO - 'HOME': '/Users/cltbld', 22:19:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:19:16 INFO - 'LOGNAME': 'cltbld', 22:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:16 INFO - 'MOZ_NO_REMOTE': '1', 22:19:16 INFO - 'NO_EM_RESTART': '1', 22:19:16 INFO - 'PAGER': '/bin/cat', 22:19:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:16 INFO - 'PWD': '/builds/slave/test', 22:19:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:19:16 INFO - 'SHELL': '/bin/bash', 22:19:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.blMYX1R446/Listeners', 22:19:16 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 22:19:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:19:16 INFO - 'USER': 'cltbld', 22:19:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:19:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:16 INFO - 'XPC_FLAGS': '0x0', 22:19:16 INFO - 'XPC_SERVICE_NAME': '0', 22:19:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:17 INFO - Downloading/unpacking jsonschema 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:19:19 INFO - Downloading/unpacking functools32 (from jsonschema) 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19:19 INFO - Downloading functools32-3.2.3-2.tar.gz 22:19:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:19:20 INFO - warning: no files found matching '*.txt' 22:19:20 INFO - no previously-included directories found matching 'build' 22:19:20 INFO - no previously-included directories found matching 'dist' 22:19:20 INFO - no previously-included directories found matching '.git*' 22:19:20 INFO - Installing collected packages: jsonschema, functools32 22:19:20 INFO - Running setup.py install for functools32 22:19:20 INFO - warning: no files found matching '*.txt' 22:19:20 INFO - no previously-included directories found matching 'build' 22:19:20 INFO - no previously-included directories found matching 'dist' 22:19:20 INFO - no previously-included directories found matching '.git*' 22:19:20 INFO - Successfully installed jsonschema functools32 22:19:20 INFO - Cleaning up... 22:19:20 INFO - Return code: 0 22:19:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:19: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')]} 22:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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')]} 22:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19: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 0x1024fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bcbf8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10239ae00>, '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 0x102203db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395b20>, '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.uho8VYpNB6/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.blMYX1R446/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 22:19: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 22:19: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 22:19:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uho8VYpNB6/Render', 22:19:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:19:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:19:20 INFO - 'HOME': '/Users/cltbld', 22:19:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:19:20 INFO - 'LOGNAME': 'cltbld', 22:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:20 INFO - 'MOZ_NO_REMOTE': '1', 22:19:20 INFO - 'NO_EM_RESTART': '1', 22:19:20 INFO - 'PAGER': '/bin/cat', 22:19:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:20 INFO - 'PWD': '/builds/slave/test', 22:19:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:19:20 INFO - 'SHELL': '/bin/bash', 22:19:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.blMYX1R446/Listeners', 22:19:20 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 22:19:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:19:20 INFO - 'USER': 'cltbld', 22:19:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:19:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:20 INFO - 'XPC_FLAGS': '0x0', 22:19:20 INFO - 'XPC_SERVICE_NAME': '0', 22:19:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:20 INFO - Downloading/unpacking flake8 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:19:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:19:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19: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 22:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:19:24 INFO - no previously-included directories found matching 'docs/_build' 22:19:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:19:24 INFO - Running setup.py install for pep8 22:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:19:24 INFO - no previously-included directories found matching 'docs/_build' 22:19:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:19:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:19:24 INFO - Cleaning up... 22:19:24 INFO - Return code: 0 22:19:24 INFO - Running post-action listener: _resource_record_post_action 22:19:24 INFO - Running post-action listener: _start_resource_monitoring 22:19:24 INFO - Starting resource monitoring. 22:19:24 INFO - ##### 22:19:24 INFO - ##### Running install step. 22:19:24 INFO - ##### 22:19:24 INFO - Running pre-action listener: _resource_record_pre_action 22:19:24 INFO - Running main action method: install 22:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:19:24 INFO - Reading from file tmpfile_stdout 22:19:24 INFO - Detecting whether we're running mozinstall >=1.0... 22:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:19:24 INFO - Reading from file tmpfile_stdout 22:19:24 INFO - Output received: 22:19:24 INFO - Usage: mozinstall [options] installer 22:19:24 INFO - Options: 22:19:24 INFO - -h, --help show this help message and exit 22:19:24 INFO - -d DEST, --destination=DEST 22:19:24 INFO - Directory to install application into. [default: 22:19:24 INFO - "/builds/slave/test"] 22:19:24 INFO - --app=APP Application being installed. [default: firefox] 22:19:24 INFO - mkdir: /builds/slave/test/build/application 22:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:19:58 INFO - Reading from file tmpfile_stdout 22:19:58 INFO - Output received: 22:19:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:19:58 INFO - Running post-action listener: _resource_record_post_action 22:19:58 INFO - ##### 22:19:58 INFO - ##### Running run-tests step. 22:19:58 INFO - ##### 22:19:58 INFO - Running pre-action listener: _resource_record_pre_action 22:19:58 INFO - Running main action method: run_tests 22:19:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:19:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:19:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:19:58 INFO - 2016-03-25 22:19:58.856 screenresolution[1643:7667] starting screenresolution argv=screenresolution get 22:19:58 INFO - 2016-03-25 22:19:58.858 screenresolution[1643:7667] Display 0: 1600x1200x32@60 22:19:58 INFO - 2016-03-25 22:19:58.864 screenresolution[1644:7669] starting screenresolution argv=screenresolution list 22:19:58 INFO - Available Modes on Display 0 22:19:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:19:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:19:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:19:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:19:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:19:59 INFO - Intel Iris: 22:19:59 INFO - Chipset Model: Intel Iris 22:19:59 INFO - Type: GPU 22:19:59 INFO - Bus: Built-In 22:19:59 INFO - VRAM (Dynamic, Max): 1536 MB 22:19:59 INFO - Vendor: Intel (0x8086) 22:19:59 INFO - Device ID: 0x0a2e 22:19:59 INFO - Revision ID: 0x0009 22:19:59 INFO - Displays: 22:19:59 INFO - Display: 22:19:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:19:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:19:59 INFO - Display Serial Number: 1600x1200 60 22:19:59 INFO - Main Display: Yes 22:19:59 INFO - Mirror: Off 22:19:59 INFO - Online: Yes 22:19:59 INFO - Rotation: Supported 22:19:59 INFO - Return code: 0 22:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:19:59 INFO - Python 2.7.3 22:19:59 INFO - Return code: 0 22:19:59 INFO - grabbing minidump binary from tooltool 22:19: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')]} 22:19:59 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10239ae00>, '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 0x102203db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102395b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:19:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:19:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 22:19:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:19:59 INFO - Return code: 0 22:19:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:19:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:19:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:19:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:19:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:20:00 INFO - Return code: 0 22:20: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/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--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 22:20: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/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0018 --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 22:20:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uho8VYpNB6/Render', 22:20:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:20:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:20:00 INFO - 'HOME': '/Users/cltbld', 22:20:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:20:00 INFO - 'LOGNAME': 'cltbld', 22:20:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:20:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:00 INFO - 'MOZ_NO_REMOTE': '1', 22:20:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:20:00 INFO - 'NO_EM_RESTART': '1', 22:20:00 INFO - 'PAGER': '/bin/cat', 22:20:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:00 INFO - 'PWD': '/builds/slave/test', 22:20:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:20:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:20:00 INFO - 'SHELL': '/bin/bash', 22:20:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.blMYX1R446/Listeners', 22:20:00 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 22:20:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:20:00 INFO - 'USER': 'cltbld', 22:20:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:20:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:00 INFO - 'XPC_FLAGS': '0x0', 22:20:00 INFO - 'XPC_SERVICE_NAME': '0', 22:20:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:20: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/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--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 22:20:00 INFO - mozversion application_buildid: 20160325194939 22:20:00 INFO - mozversion application_changeset: 5579b62017f217581e1d414f801166c7d55d4f4c 22:20:00 INFO - mozversion application_display_name: Nightly 22:20:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:20:00 INFO - mozversion application_name: Firefox 22:20:00 INFO - mozversion application_remotingname: firefox 22:20:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:20:00 INFO - mozversion application_vendor: Mozilla 22:20:00 INFO - mozversion application_version: 48.0a1 22:20:00 INFO - mozversion platform_buildid: 20160325194939 22:20:00 INFO - mozversion platform_changeset: 5579b62017f217581e1d414f801166c7d55d4f4c 22:20:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:20:00 INFO - mozversion platform_version: 48.0a1 22:20:00 INFO - using testdate: 1458969600 22:20:00 INFO - actual date: 1458969600 22:20:00 INFO - starting webserver on 'localhost:49274' 22:20:00 INFO - SUITE-START | Running 2 tests 22:20:00 INFO - TEST-START | dromaeo_css 22:20:00 INFO - operating with platform_type : mac_ 22:20:00 INFO - Initialising browser for dromaeo_css test... 22:20:00 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpU9UkLm/profile http://localhost:49274/getInfo.html) 22:20:03 INFO - PROCESS | 1662 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 22:20:03 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 22:20:03 INFO - PROCESS | 1662 | colorDepth:24 22:20:03 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 22:20:03 INFO - PROCESS | 1662 | __metrics 22:20:03 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 22:20:04 INFO - TEST-INFO | 1662: exit 0 22:20:04 INFO - Browser initialized. 22:20:04 INFO - Running cycle 1/1 for dromaeo_css test... 22:20:04 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpU9UkLm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:16 INFO - PROCESS | 1666 | RSS: Main: 254709760 22:20:16 INFO - PROCESS | 1666 | 22:21:06 INFO - PROCESS | 1666 | 1458969666105 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] 22:23:16 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 22:23:18 INFO - PROCESS | 1666 | RSS: Main: 268410880 22:23:18 INFO - PROCESS | 1666 | 22:26:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 22:26:20 INFO - PROCESS | 1666 | RSS: Main: 279097344 22:26:20 INFO - PROCESS | 1666 | 22:29:22 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 22:29:22 INFO - PROCESS | 1666 | RSS: Main: 281112576 22:29:22 INFO - PROCESS | 1666 | 22:32:24 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 22:32:25 INFO - PROCESS | 1666 | RSS: Main: 282648576 22:32:25 INFO - PROCESS | 1666 | 22:35:27 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 22:35:28 INFO - PROCESS | 1666 | RSS: Main: 285462528 22:35:28 INFO - PROCESS | 1666 | 22:38:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 22:38:31 INFO - PROCESS | 1666 | RSS: Main: 286814208 22:38:31 INFO - PROCESS | 1666 | 22:38:31 INFO - PROCESS | 1666 | __start_tp_report 22:38:31 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 22:38:31 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 22:38:31 INFO - PROCESS | 1666 | |i|pagename|runs| 22:38:31 INFO - PROCESS | 1666 | |0;dojo.html;2939.4562006028887;2943.8233705977655;3548.5032095506635;3561.590417102034;3636.909077273068;5893.852653683654;5894.292684877821;5921.703914804259;5922.132886153908;5925.940740592593;5762.279715035621;5815.273090863642;5860.208871802305;5905.557083218765;5945.316288626809;5259.526642602165;5322.7072511012075;5342.118550439173;5363.597730170233;5415.891682166354;5368.677879327252;5387.4612538746005;5412.91880621789;5440.591955603326;5457.126859702448;5226.033183860998;5254.52709256165;5315.176147697113;5346.224797404393;5349.358077030781;5336.092864213093;5339.519443250126;5342.973285133588;5368.087425137736;5437.157240627669;5062.721550314731;5248.291480650139;5308.761105750251;5352.384475785296;5359.410464848864;5826.504747096502;5836.416358364172;5880.7353669085;5888.764449422018;5889.381614930414;6184.938150618481;6225.284092329395;6229.781957631507;6237.157983672191;6246.500279977591;6165.815025549241;6192.195014648112;6259.186305780219;6271.27880293763;6272.843178920518;6019.819405417845;6031.60794548353;6036.8188954331445;6039.396060394013;6096.695165241765;6322.620642761449;6356.618602883842;6360.618362898241;6373.298937116913;6385.2656944451055;6113.841195312687;6168.1056246844855;6212.565120441525;6258.436740693269;6259.499240060784;6111.19673459643;6192.195014648157;6251.218597675291;6278.905816412757;6288.811335659938;6159.630422174594;6210.813675589739;6235.127082208494;6243.37566243372;6257.812265632038;5199.324087868553;6166;6173.938260617337;6219.440250377488;6228.813135605939;4934.18585933317;4970.502949705001;4980.90038199234;4987.975060124676;4993.900121997613;3824.847006119724;4504;4508.32375143731;4522.751248681288;4535.251683472256;5833.708314584339;5932.3177834548715;5961.105834124829;5966.76132954677;6053.606515576562;6237.844053898689;6242.968785156045;6251.218597675291;6256.468200202943;6448.967755161194;5872.4421179988685;5990.272885793367;6006.579539432198;6031.306399764083;6059.909101363483;5440.292761940922;5525.972370138124;5532.253145825262;5564.805231816867;5569.777208911598;6498.675066246763;6523.673816309166;6554.180727409074;6558.606483611094;6568.080468734381;6069.787557435468;6170.598911070766;6220.284667263141;6259.78090766821;6267.780627678009;6391.424771770563;6449.3873082057125;6515.73937042513;6526.314736952741;6528.706208220737;5589.413111623384;6121.816345509642;6166.630002199882;6184.226971628546;6204.069389591597;6142.262928448615;6152.261728592597;6290.182276304051;6300.558960872695;6305.8108256752375;6120.2947619997085;6179.011358182669;6191.907121393093;6200.627962322275;6203.666211764492;5953.940460595339;6157.9384206157365;6161.84595385119;6169.629822210682;6180.381961803783;6048.425399587032;6088.726007329769;6112.1995365628145;6135.478484328882;6161.44546990773;6159.907601386072;6176.66028368444;6176.907346389898;6210.937890621036;6211.099390588249;6180.289266734383;6191.071339299141;6198.535109866688;6209.813705588839;6227.657478838526 22:38:31 INFO - PROCESS | 1666 | |1;ext.html;436.67031391299565;506.80488012115336;574.7557288152536;602.3855667219439;623.937606239376;36878.815605922;37496.62503374965;37503.06242343943;37550.8122459388;37623.81188094059;38207.61792382082;38748.80625596868;38849.83450496483;38898.8055059725;38905.02737431566;9190.770230744218;9431.056894310548;9437;9447.196988256006;9518;9203.263738900905;9315.813683726321;9328.860067098998;9329.253659707207;9397.389169703947;8216.383771217153;9286.489243091628;9305.302102342317;9398.201152902011;9400.153986141246;9405.85891211629;9483.573239204217;9489.288303377274;9500.572474238676;9510.714678559654;8211.548364839931;9586.137247647675;9591.136797688172;9593.280503962162;9620.470874101922;38107.61892381068;38358.04104897372;38415;38547;38704.22591548153;3143.167060728909;3171.8414079295944;3175.412548678502;3223;3404.268082362304;23723.525529489314;26232.213033609023;27832.30419239515;27855.16434506968;28132.01537946162;2488.9875550622314;2707.10665480391;2721.265258380246;2807.985960070207;2886.2495751104652;353972;420174;423748;424156;427491;57331;64014.399640009375;64233.678831605546;64347.35652643508;64618.35381646217;70156.29843701498;71322.9301560477;72039.27960720325;73221.2677873225;73681.6315918417;13884.375203115884;16383.508494745176;16760.245788939526;16889.577760556083;16890.662186756195;12563.874361256454;12979.156354837094;12981.870181298254;13034.674133146747;13041.152325098838;20450.693239601416;20707.964601770153;20793.96030198484;20850.853203073977;21511;7666.731664391719;9261.30540209487;9267.053918677153;9271.490068046322;9280.443173409618;939.6805086270564;978.4178413843752;986.1026465915982;989.8861630912393;1017.4709151241314;25040.749592504206;28967.986120485682;29206.707932920825;29619.407611847644;29808.552871706943;1053.963111291101;1160.2980196980704;1182.6747644397688;1188.536470776398;1223.5839814463125;14726.852731472762;14894.70210595782;14910.776338354934;14920.12573307042;15200.239988000776;509435;512726;514343;515773;521323;55340.72329638326;56651.15023274654;56767.432325676215;57400.42599573951;57491.42508574944;1440.9279536023157;1441.6467965348347;1452.4625888421351;1457.9052361596462;1466.113001633996;28755.13734587966;28803.44779424955;28904.7109528902;29211.7078829209;29612.815487380263;48640;49567.00865982588;49620.75189624029;49913;50016.499835002636;498176;509692.4515377548;514685;516309;516662;33015.17462063468;33017.834910825295;33071.66928330686;33479.66520334766;33677.49483757697;43741.34387984119;43925;44310;44796.55203447924;45086.32370514511;35935.92192234237;36685;36831.63168368282;37041.25917481689;37201.511939523196;36473.817630911675;36658.8167059163;36764.816175920016;37157.81421092877;37233.44149837809;34889.47665785066;35595.288094237454;36138;36471.45292820557;36869;30047.248818779706;31810.705554749813;32043.839780801878;32370;32491.512627311084;24026.15908443196;24152;24236.272911812674;24560;24575.508489829746 22:38:31 INFO - PROCESS | 1666 | |2;jquery.html;361.2504054087767;362.262795211744;370.62011438275766;376.2681584318498;376.9811509424528;19986.800131998676;20223.39329820106;20749.273775417863;21272.89363553184;21558.89220553899;20616.896915515437;20956.476088097806;21088.36734897952;21218.363449096552;21274.042668079936;5624.831255062344;5874.5594080443925;5883.352831188566;5885.146653735227;5887.058070708687;5444.183372494118;5654.406287339832;5695.373508914016;5756.8272951811305;5759.510441612468;5649.576281778863;5676.687782171979;5706.9429305707035;5712.514436272901;5720.056190728525;5331.493508116742;5447.782088716466;5477.1510415885405;5728.914066289009;5736.598438109334;5004.424491183488;5009.599232061426;5013.0725815723845;5029.371328583927;5038.067957427887;25536.744632553808;25918.870405647853;26120.73879261202;26176.9529218831;26214.606780898303;2114.080375036864;2215.634420320645;2309.8036666883336;2333.0667732906804;2581.7031041430287;9341.392809467363;14833.629159270997;15055.47305844301;15129.470468533658;15401.922990384975;1615.515345396388;1719.759233707282;1808.1501694203835;1831.6611426886068;1936.6514027475048;104949.47525262325;107338.8532229351;108030;108597.91402086036;108787;9317.627294908129;9574.425534467955;11167.218294719292;11255.66233013011;11296.943515282372;13514.662133446742;13542.45830166802;13560;13568.457261709618;13606.727865442635;8342.62458189383;8474.788130296793;8499.640057590756;8573.314134869195;8585.18440748128;8530.87203691945;8542.82914341722;8608.741737747878;8645.481271123752;8715.738527844174;3707.6107008763693;4394.659628813179;4416.889577760582;4442.955570444255;4448.733076015449;1650.5378494021693;1885.9528511787041;1917.3864363403857;1926.5280006398523;1938.7188857615567;928.6563971330651;1001.9549120289604;1008.6419321141036;1016.3546148195949;1032.3031953431555;20485.48786280325;20602;20868.26961056386;20915.79084209169;20981.895090524755;877.9078196789245;930.469632309577;953.7806304549993;1030.4178139351243;1063.409807556798;10954.835677464844;11205.271657342246;11257;11276.267042642203;11278.436078196057;592914;596842;605245;610205;611658;91022;101791;102788;110411.44794276138;114408.99137060493;989.5942663508071;999.8102258312584;1024;1026.6714651311659;1034.8551202831609;18522.444326670222;18742.53143671419;18825.623487530447;18836.717449238;19139.330123445612;48912;50489.990200196524;50577.49422505728;51595.96808063742;52151.47848521466;69962;72188.19529511804;72753;73120.51596130205;73667.6316618435;6023.909641355295;6561.934380656132;6916.997035429734;7765.495242809199;7806.41451891099;8988.280937525113;10475.371477711362;11614.535418583162;12462.252264864137;12916.612501624966;11121.555137794398;11149.665510034712;11188.440577970907;11379.089672825989;11489.885101148882;9178.586963586522;10657.307275027099;11031.282966607145;11432.256903301259;11672.840524502994;9130.269578433577;11223.55105795759;11402.087832973508;11441.199116061796;11562.710932226762;7943.801404964922;7944.04671439431;7959.721409750631;7986.720464783704;8052.959735201521;9392.925430210293;11427.200095993201;11477.36874471912;11483.885161148282;11732.530698771954 22:38:31 INFO - PROCESS | 1666 | |3;mootools.html;1589.3086507369296;1593.7370333894905;1693.6443346897152;1850.888946663201;1863.1522657190978;8073.031236251643;8778.824423511525;8817.162369574888;9054.04932482089;9068.727938161857;8789.25291350236;8801.471911685303;8831.249343805768;8882.77793055174;8921.286297096232;2401.1955994741784;2503.674522312106;2505.924822255335;2511.5981442969037;2518.6725725655638;2453.7300896901324;2500.3499090236487;2508.385445565839;2508.636247744076;2510.5230006298834;2475.938101547458;2483.552960467115;2527.772500474957;2536.087008676875;2548.3501707064675;2490.0786708917726;2523.356544081266;2523.7602427769425;2529.481456301472;2532.050481069599;2175.695402643631;2482.354587807183;2500.8499490030476;2514.170323793144;2540.2506260653154;8965.820683586291;8968.327375446803;8982.685606003824;9029.729108126767;9036.322275829274;5497.45025497451;5583.972080139573;5604.467575580314;5608.691521966291;5662.207290979266;3536.381133301662;3600.837962291677;3670.2475992421755;3676.8713095041544;3691.206390626028;1011.949402529878;1052.5000624703205;1055.8732952045727;1057.3074636113358;1058.2327812336073;12114.757704845942;12144.02847772185;12180.81728774069;12231.816522752166;12246.632601021984;4230.598093181143;4884.3650325457465;4932.482089380635;4993.177490216045;5032.874178145503;10058.849117263248;10089.798204036026;10192.286539942133;10279.17766578672;10284.897151028543;5539.14143307788;5542.972285138549;5570.498655121059;5585.553155747531;5594.776208951678;4535.750533720677;4879.072976134523;4993.775280112403;5036.068327359377;5044.520770526794;3445.6554344565843;3852.9807350963065;3952.130531283113;3976.4631774710624;3995.5005624296964;1198.3828328410875;1326.37660299659;1338.5248236875768;1340.5107135895328;1348.4538761801487;1127.9548818047351;1140.4696815980442;1152.619635520293;1311.4098655605017;1389.1456754096157;8073.6770529178175;8229.382796290183;8264.793380165544;8394.79013024667;8434.57827108642;528.197140346671;533.4318950317898;534.7914313417771;540.3326891289255;542.0243561589202;6244.375562443719;6250.281217659936;6290.685465726695;6305.936940630627;6327.905081423783;9230.58462369195;9657.613695452103;10720.303180293256;10981.725456863482;11075.667729968114;10416.166706663449;10573.20700947432;10656.893431065746;10700.090492308242;10746.399082454893;6711.832204194934;8398.664053437795;8414.873776893352;8473.915260847436;8543.316534677211;7935.2064793520185;7979.680812767657;7980.241877021674;7998.800029999296;8054.959725201336;8007.919920800718;9679.758006049906;9710.368826026286;9717.27120465982;9764.853527196956;9615.9038409615;9904.405735655884;9910.950445247727;10034.996500349907;10165.491725413847;6825.078614387193;7337.156227033959;7541.283578060075;7560.697572097055;7618.542887426772;8395.83208335842;8410.53742044169;8420.915790842013;8437.620307086074;8481.27909127731;7381.44639152055;7543.73596924105;7590.886136707843;7591.962040189764;7632.19861914491;7351.70593176267;7361.447891408059;7362.705491780269;7432.2567743225245;7467.850642987001;7874.251946065115;7917.089534703583;7931.643076061707;7934.801629959297;7953.085395179397;7069.045678833291;7163.31948464895;7177.856442871218;7215.71137154508;7229.024081748897;7213.242609526134;7244.094488188976;7260.419166466776;7292.562446253241;7298.890516642361 22:38:31 INFO - PROCESS | 1666 | |4;prototype.html;331.39354980385895;331.76444724245783;337.421322432029;339.4178983044079;340.6168060931452;6792.049113124167;6833.965830170855;6845.452363810896;6865.347791959762;6866.382025617693;6677.065210870482;6688.732450701978;6692.2303935047485;6785.864282714343;6787.389134977851;4774.283857421397;4838.637102217348;4975.179095449264;4989.525995030466;5032.421271553772;4955.975220123894;4974.452810190876;4978.850634480953;4980.35648236083;4987.426445958725;4873.098476781789;4893.730844803535;4916.065947469987;4919.975400123012;4923.679960802554;4916.729579873106;4971.0803501352;4974.950250497485;4988.176950803131;4992.350994370745;3706.8517259309597;3853.689745486548;3861.9227615447817;4273.102648443831;4283.550227226127;6357.4914006879335;6535.836604084889;6626.039224312448;6639;6644.970029645413;4801.231802911552;5870.943230218559;5906.793262235844;5915.645061296336;5917.319508256563;7267.055282813253;7271.381932535741;7290.635468226567;7301;7303.196648368676;4775.498572649891;4786.952130478686;4794.113089078532;4801.255805350142;4807.879803004917;7665.540067595962;7704.499207551547;7704.6918123275;7709.922900770976;7719.614019299069;4378.277584198571;4744.240921452551;4818.204996175662;4840.491748366371;4852.757362131879;4147.6474499667265;4918.754062296871;4943.110240156734;4951.529604687549;4954.405471343462;5851.61964472308;5893.675847828325;5897.233359663216;5911.349751527328;5921.585489015728;7341.963290183622;7344.779656610311;7357.3378395943555;7358.926410735824;7365.226651201547;1614.5237155039292;1660.3192690996634;1703.131402984462;1713.7600735896985;1729.135432283858;951.4814426137772;1093.6500319897716;1103.2938919091787;1114.3481063577897;1120.0815331428314;5161.225816127536;5803.941960580424;6696.7656132035145;6702.698378572976;6711.932880671131;7450.627468626547;7455.627218639046;7457.067866516685;7461.291177338144;7468.10382754073;6660.83347916306;6678.9332106679285;6681.699323530453;6709;6720.126383570202;3461.567304086989;3982.6415622593527;3998.020484981198;4013.6387725104883;4017.738846974937;7472.626368681653;7810.336121429628;7814.68741250355;7815.29662330393;7856.33221176195;7641.923580764233;7650.579218142944;7665.156832748393;7683.769486915289;7710;7770;7794.727184548514;7800.297973182441;7818.6090695465;7836.216378362232;7369.152547456896;7397.556146631219;7401;7411.2588741125455;7421.183669796426;5818.010938140611;6877.346652068046;7347.559146451016;7541.472096953161;7616.200298968529;8091.231333023354;8091.90759247494;8096.109427963037;8132.2680958714;8145.470544414594;3868.9419658705706;4743.525647435229;4745.38310019709;4758.405199350082;4762.857114286577;7372;7681.884771728317;7688.346490548366;7698.191689872707;7705.30652241301;7338.376238019615;7374.963125184339;7378.815529611803;7380;7418.851622967619;6617.8014659560295;6725.327467253235;7346.375558077623;7349.742759003409;7432.591207483641;7181.497295189287;7211.639418029183;7217.566945983048;7222.133343998754;7244.673989670372;7057.682404291922;7365;7391.186969433251;7392.630368481662;7445.255474452511;7203.927960720326;7212.350888420067;7233.710651573878;7241.456890733321;7256.96371518139 22:38:31 INFO - PROCESS | 1666 | |5;yui.html;643.1960049937578;677.4715721737044;686.1114856261141;689.2211800665248;690.2441826200312;13020.348982550859;13824.239666818321;13910.234937078456;14063.29683515824;15440.536783896501;14555.490557830479;14561.126332420063;14604.415823367079;14659.340329685163;14747.705045899102;874.2437791310502;894.9149830766083;916.9128932751378;921.3136213520903;921.4609453469728;787.5747096567875;887.7114937645259;900.275278400887;912.2975309012056;917.454114801692;802.7837825694078;930.3115694386139;939.178219058324;945.4563625915092;945.7871978804783;898.128815049401;902.7111324376202;908.6002159049997;923.8845144356922;950.5009869818332;674.5514233035026;677.5155763629028;691.3881215124651;696.7039008421401;701.421327404888;13072.673183170402;14179.361928713233;14337.49818756349;14472.204028778413;14486.42054317826;11689.766204675943;11841.40792960357;11942.522299108025;11960;12106.515739370414;9323;9348.846703408875;9415.858762118505;9588.232941364744;9597.808043839153;3280.6883346082086;3313.5692359993286;3332.800031998088;3358.529805827186;3427.2288735034667;57228;73227.80316590564;76383.6180819098;77208;77255.22744772593;8524.488530688179;8530.189631984951;8656.740297791077;8719.520426376483;8835.602397891982;18983.81016189848;19034.85924822389;19045.333413330743;19046;19100.713489297672;6033.5173186145;6748.257691653914;6980.546264492792;7033.9296607033275;7039.979203015534;3803.1823158020607;3847.5960024197616;3865.7873816939777;3880.1463677990796;3884.1454879926373;3332.3501917126414;3382.5095361172494;3382.9323413531592;3387.7289816814596;3387.983060084684;605.8636806718541;608.4068033667139;616.8457885528618;624.3257282135284;631.6904716688789;574.3309044962572;589.3252226200976;592.3572923378183;609.430182779103;620.5656040771388;7750.14748377678;7790.883136752953;7874.330681891989;7989.600519973978;7995.2804247618;499.17885079045493;542.5984771269233;576.8384852241379;577.431230238215;603.4900509069829;2823.901163459269;3349.246419555629;3502.6322236164838;3753.756005859665;3843.2889915365745;86312;90620.6406903897;92289.61565576521;93066.53466732758;93811;79524.80712789313;79894;80049;80979.5951020253;81119.18880811235;71231;72088;74772.62613686897;75070.6246468775;75136.4972700532;6424.51816113784;7879.409044321585;8267.710630127916;8333.041700204554;8338.70814521513;49480.51558453252;50630.74684626701;50984.235236472225;51733.482665172865;54272;65983;71164;72246;73542.63228684037;74799;10472.581096756348;10474.68575942723;10493.108085812792;10537.209709271989;10808.891911081104;11336.886631133582;11593.536258549564;11835;11934.701632459259;12089.758204835678;10768.300060496043;10772.138228941823;11042.889571104186;11192.552297907992;11195.552177913118;10452.738681532719;10585.994330538586;10588.41763702973;10706.250562460553;10788.784224315626;10406.01142891424;10470.633527826489;10715.678529644123;10724.785504290026;10995.725106872393;9255.35212535143;9295.907040929504;9302.906970930475;9677.854832177381;9709.757256068373;7525.623718813928;8650.264727498234;8866.290696744116;9145.413870246084;9162.358634895494 22:38:31 INFO - PROCESS | 1666 | __end_tp_report 22:38:31 INFO - PROCESS | 1666 | __start_cc_report 22:38:31 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,366 22:38:31 INFO - PROCESS | 1666 | __end_cc_report 22:38:31 INFO - PROCESS | 1666 | __startTimestamp1458970711256__endTimestamp 22:38:31 INFO - PROCESS | 1666 | 22:38:31 INFO - PROCESS | 1666 | ------- Summary: start ------- 22:38:31 INFO - PROCESS | 1666 | Number of tests: 6 22:38:31 INFO - PROCESS | 1666 | 22:38:31 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5835.53 Median:6112.20 stddev:655.96 (10.7%) stddev-sans-first:617.37 22:38:31 INFO - PROCESS | 1666 | Values: 2939.5 2943.8 3548.5 3561.6 3636.9 5893.9 5894.3 5921.7 5922.1 5925.9 5762.3 5815.3 5860.2 5905.6 5945.3 5259.5 5322.7 5342.1 5363.6 5415.9 5368.7 5387.5 5412.9 5440.6 5457.1 5226.0 5254.5 5315.2 5346.2 5349.4 5336.1 5339.5 5343.0 5368.1 5437.2 5062.7 5248.3 5308.8 5352.4 5359.4 5826.5 5836.4 5880.7 5888.8 5889.4 6184.9 6225.3 6229.8 6237.2 6246.5 6165.8 6192.2 6259.2 6271.3 6272.8 6019.8 6031.6 6036.8 6039.4 6096.7 6322.6 6356.6 6360.6 6373.3 6385.3 6113.8 6168.1 6212.6 6258.4 6259.5 6111.2 6192.2 6251.2 6278.9 6288.8 6159.6 6210.8 6235.1 6243.4 6257.8 5199.3 6166.0 6173.9 6219.4 6228.8 4934.2 4970.5 4980.9 4988.0 4993.9 3824.8 4504.0 4508.3 4522.8 4535.3 5833.7 5932.3 5961.1 5966.8 6053.6 6237.8 6243.0 6251.2 6256.5 6449.0 5872.4 5990.3 6006.6 6031.3 6059.9 5440.3 5526.0 5532.3 5564.8 5569.8 6498.7 6523.7 6554.2 6558.6 6568.1 6069.8 6170.6 6220.3 6259.8 6267.8 6391.4 6449.4 6515.7 6526.3 6528.7 5589.4 6121.8 6166.6 6184.2 6204.1 6142.3 6152.3 6290.2 6300.6 6305.8 6120.3 6179.0 6191.9 6200.6 6203.7 5953.9 6157.9 6161.8 6169.6 6180.4 6048.4 6088.7 6112.2 6135.5 6161.4 6159.9 6176.7 6176.9 6210.9 6211.1 6180.3 6191.1 6198.5 6209.8 6227.7 22:38:31 INFO - PROCESS | 1666 | 22:38:31 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:62492.76 Median:37587.31 stddev:127978.20 (340.5%) stddev-sans-first:128252.40 22:38:31 INFO - PROCESS | 1666 | Values: 436.7 506.8 574.8 602.4 623.9 36878.8 37496.6 37503.1 37550.8 37623.8 38207.6 38748.8 38849.8 38898.8 38905.0 9190.8 9431.1 9437.0 9447.2 9518.0 9203.3 9315.8 9328.9 9329.3 9397.4 8216.4 9286.5 9305.3 9398.2 9400.2 9405.9 9483.6 9489.3 9500.6 9510.7 8211.5 9586.1 9591.1 9593.3 9620.5 38107.6 38358.0 38415.0 38547.0 38704.2 3143.2 3171.8 3175.4 3223.0 3404.3 23723.5 26232.2 27832.3 27855.2 28132.0 2489.0 2707.1 2721.3 2808.0 2886.2 353972.0 420174.0 423748.0 424156.0 427491.0 57331.0 64014.4 64233.7 64347.4 64618.4 70156.3 71322.9 72039.3 73221.3 73681.6 13884.4 16383.5 16760.2 16889.6 16890.7 12563.9 12979.2 12981.9 13034.7 13041.2 20450.7 20708.0 20794.0 20850.9 21511.0 7666.7 9261.3 9267.1 9271.5 9280.4 939.7 978.4 986.1 989.9 1017.5 25040.7 28968.0 29206.7 29619.4 29808.6 1054.0 1160.3 1182.7 1188.5 1223.6 14726.9 14894.7 14910.8 14920.1 15200.2 509435.0 512726.0 514343.0 515773.0 521323.0 55340.7 56651.2 56767.4 57400.4 57491.4 1440.9 1441.6 1452.5 1457.9 1466.1 28755.1 28803.4 28904.7 29211.7 29612.8 48640.0 49567.0 49620.8 49913.0 50016.5 498176.0 509692.5 514685.0 516309.0 516662.0 33015.2 33017.8 33071.7 33479.7 33677.5 43741.3 43925.0 44310.0 44796.6 45086.3 35935.9 36685.0 36831.6 37041.3 37201.5 36473.8 36658.8 36764.8 37157.8 37233.4 34889.5 35595.3 36138.0 36471.5 36869.0 30047.2 31810.7 32043.8 32370.0 32491.5 24026.2 24152.0 24236.3 24560.0 24575.5 22:38:31 INFO - PROCESS | 1666 | 22:38:31 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:33986.67 Median:14059.22 stddev:99836.08 (710.1%) stddev-sans-first:100084.22 22:38:31 INFO - PROCESS | 1666 | Values: 361.3 362.3 370.6 376.3 377.0 19986.8 20223.4 20749.3 21272.9 21558.9 20616.9 20956.5 21088.4 21218.4 21274.0 5624.8 5874.6 5883.4 5885.1 5887.1 5444.2 5654.4 5695.4 5756.8 5759.5 5649.6 5676.7 5706.9 5712.5 5720.1 5331.5 5447.8 5477.2 5728.9 5736.6 5004.4 5009.6 5013.1 5029.4 5038.1 25536.7 25918.9 26120.7 26177.0 26214.6 2114.1 2215.6 2309.8 2333.1 2581.7 9341.4 14833.6 15055.5 15129.5 15401.9 1615.5 1719.8 1808.2 1831.7 1936.7 104949.5 107338.9 108030.0 108597.9 108787.0 9317.6 9574.4 11167.2 11255.7 11296.9 13514.7 13542.5 13560.0 13568.5 13606.7 8342.6 8474.8 8499.6 8573.3 8585.2 8530.9 8542.8 8608.7 8645.5 8715.7 3707.6 4394.7 4416.9 4443.0 4448.7 1650.5 1886.0 1917.4 1926.5 1938.7 928.7 1002.0 1008.6 1016.4 1032.3 20485.5 20602.0 20868.3 20915.8 20981.9 877.9 930.5 953.8 1030.4 1063.4 10954.8 11205.3 11257.0 11276.3 11278.4 592914.0 596842.0 605245.0 610205.0 611658.0 91022.0 101791.0 102788.0 110411.4 114409.0 989.6 999.8 1024.0 1026.7 1034.9 18522.4 18742.5 18825.6 18836.7 19139.3 48912.0 50490.0 50577.5 51596.0 52151.5 69962.0 72188.2 72753.0 73120.5 73667.6 6023.9 6561.9 6917.0 7765.5 7806.4 8988.3 10475.4 11614.5 12462.3 12916.6 11121.6 11149.7 11188.4 11379.1 11489.9 9178.6 10657.3 11031.3 11432.3 11672.8 9130.3 11223.6 11402.1 11441.2 11562.7 7943.8 7944.0 7959.7 7986.7 8053.0 9392.9 11427.2 11477.4 11483.9 11732.5 22:38:31 INFO - PROCESS | 1666 | 22:38:31 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:6100.88 Median:5518.30 stddev:3231.09 (58.6%) stddev-sans-first:3222.36 22:38:31 INFO - PROCESS | 1666 | Values: 1589.3 1593.7 1693.6 1850.9 1863.2 8073.0 8778.8 8817.2 9054.0 9068.7 8789.3 8801.5 8831.2 8882.8 8921.3 2401.2 2503.7 2505.9 2511.6 2518.7 2453.7 2500.3 2508.4 2508.6 2510.5 2475.9 2483.6 2527.8 2536.1 2548.4 2490.1 2523.4 2523.8 2529.5 2532.1 2175.7 2482.4 2500.8 2514.2 2540.3 8965.8 8968.3 8982.7 9029.7 9036.3 5497.5 5584.0 5604.5 5608.7 5662.2 3536.4 3600.8 3670.2 3676.9 3691.2 1011.9 1052.5 1055.9 1057.3 1058.2 12114.8 12144.0 12180.8 12231.8 12246.6 4230.6 4884.4 4932.5 4993.2 5032.9 10058.8 10089.8 10192.3 10279.2 10284.9 5539.1 5543.0 5570.5 5585.6 5594.8 4535.8 4879.1 4993.8 5036.1 5044.5 3445.7 3853.0 3952.1 3976.5 3995.5 1198.4 1326.4 1338.5 1340.5 1348.5 1128.0 1140.5 1152.6 1311.4 1389.1 8073.7 8229.4 8264.8 8394.8 8434.6 528.2 533.4 534.8 540.3 542.0 6244.4 6250.3 6290.7 6305.9 6327.9 9230.6 9657.6 10720.3 10981.7 11075.7 10416.2 10573.2 10656.9 10700.1 10746.4 6711.8 8398.7 8414.9 8473.9 8543.3 7935.2 7979.7 7980.2 7998.8 8055.0 8007.9 9679.8 9710.4 9717.3 9764.9 9615.9 9904.4 9911.0 10035.0 10165.5 6825.1 7337.2 7541.3 7560.7 7618.5 8395.8 8410.5 8420.9 8437.6 8481.3 7381.4 7543.7 7590.9 7592.0 7632.2 7351.7 7361.4 7362.7 7432.3 7467.9 7874.3 7917.1 7931.6 7934.8 7953.1 7069.0 7163.3 7177.9 7215.7 7229.0 7213.2 7244.1 7260.4 7292.6 7298.9 22:38:31 INFO - PROCESS | 1666 | 22:38:31 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5936.24 Median:6705.85 stddev:1932.81 (28.8%) stddev-sans-first:1891.89 22:38:31 INFO - PROCESS | 1666 | Values: 331.4 331.8 337.4 339.4 340.6 6792.0 6834.0 6845.5 6865.3 6866.4 6677.1 6688.7 6692.2 6785.9 6787.4 4774.3 4838.6 4975.2 4989.5 5032.4 4956.0 4974.5 4978.9 4980.4 4987.4 4873.1 4893.7 4916.1 4920.0 4923.7 4916.7 4971.1 4975.0 4988.2 4992.4 3706.9 3853.7 3861.9 4273.1 4283.6 6357.5 6535.8 6626.0 6639.0 6645.0 4801.2 5870.9 5906.8 5915.6 5917.3 7267.1 7271.4 7290.6 7301.0 7303.2 4775.5 4787.0 4794.1 4801.3 4807.9 7665.5 7704.5 7704.7 7709.9 7719.6 4378.3 4744.2 4818.2 4840.5 4852.8 4147.6 4918.8 4943.1 4951.5 4954.4 5851.6 5893.7 5897.2 5911.3 5921.6 7342.0 7344.8 7357.3 7358.9 7365.2 1614.5 1660.3 1703.1 1713.8 1729.1 951.5 1093.7 1103.3 1114.3 1120.1 5161.2 5803.9 6696.8 6702.7 6711.9 7450.6 7455.6 7457.1 7461.3 7468.1 6660.8 6678.9 6681.7 6709.0 6720.1 3461.6 3982.6 3998.0 4013.6 4017.7 7472.6 7810.3 7814.7 7815.3 7856.3 7641.9 7650.6 7665.2 7683.8 7710.0 7770.0 7794.7 7800.3 7818.6 7836.2 7369.2 7397.6 7401.0 7411.3 7421.2 5818.0 6877.3 7347.6 7541.5 7616.2 8091.2 8091.9 8096.1 8132.3 8145.5 3868.9 4743.5 4745.4 4758.4 4762.9 7372.0 7681.9 7688.3 7698.2 7705.3 7338.4 7375.0 7378.8 7380.0 7418.9 6617.8 6725.3 7346.4 7349.7 7432.6 7181.5 7211.6 7217.6 7222.1 7244.7 7057.7 7365.0 7391.2 7392.6 7445.3 7203.9 7212.4 7233.7 7241.5 7257.0 22:38:31 INFO - PROCESS | 1666 | 22:38:31 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18007.26 Median:628.01 stddev:25814.22 (4110.5%) stddev-sans-first:25853.71 22:38:31 INFO - PROCESS | 1666 | Values: 643.2 677.5 686.1 689.2 690.2 13020.3 13824.2 13910.2 14063.3 15440.5 14555.5 14561.1 14604.4 14659.3 14747.7 874.2 894.9 916.9 921.3 921.5 787.6 887.7 900.3 912.3 917.5 802.8 930.3 939.2 945.5 945.8 898.1 902.7 908.6 923.9 950.5 674.6 677.5 691.4 696.7 701.4 13072.7 14179.4 14337.5 14472.2 14486.4 11689.8 11841.4 11942.5 11960.0 12106.5 9323.0 9348.8 9415.9 9588.2 9597.8 3280.7 3313.6 3332.8 3358.5 3427.2 57228.0 73227.8 76383.6 77208.0 77255.2 8524.5 8530.2 8656.7 8719.5 8835.6 18983.8 19034.9 19045.3 19046.0 19100.7 6033.5 6748.3 6980.5 7033.9 7040.0 3803.2 3847.6 3865.8 3880.1 3884.1 3332.4 3382.5 3382.9 3387.7 3388.0 605.9 608.4 616.8 624.3 631.7 574.3 589.3 592.4 609.4 620.6 7750.1 7790.9 7874.3 7989.6 7995.3 499.2 542.6 576.8 577.4 603.5 2823.9 3349.2 3502.6 3753.8 3843.3 86312.0 90620.6 92289.6 93066.5 93811.0 79524.8 79894.0 80049.0 80979.6 81119.2 71231.0 72088.0 74772.6 75070.6 75136.5 6424.5 7879.4 8267.7 8333.0 8338.7 49480.5 50630.7 50984.2 51733.5 54272.0 65983.0 71164.0 72246.0 73542.6 74799.0 10472.6 10474.7 10493.1 10537.2 10808.9 11336.9 11593.5 11835.0 11934.7 12089.8 10768.3 10772.1 11042.9 11192.6 11195.6 10452.7 10586.0 10588.4 10706.3 10788.8 10406.0 10470.6 10715.7 10724.8 10995.7 9255.4 9295.9 9302.9 9677.9 9709.8 7525.6 8650.3 8866.3 9145.4 9162.4 22:38:31 INFO - PROCESS | 1666 | -------- Summary: end -------- 22:38:31 INFO - PROCESS | 1666 | 22:38:31 INFO - TEST-INFO | 1666: exit 0 22:38:31 INFO - TEST-OK | dromaeo_css | took 1111182ms 22:38:31 INFO - TEST-START | kraken 22:38:31 INFO - operating with platform_type : mac_ 22:38:31 INFO - Initialising browser for kraken test... 22:38:31 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpE5XPD_/profile http://localhost:49274/getInfo.html) 22:38:33 INFO - PROCESS | 1675 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 22:38:34 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 22:38:34 INFO - PROCESS | 1675 | colorDepth:24 22:38:34 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 22:38:34 INFO - PROCESS | 1675 | __metrics 22:38:34 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 22:38:35 INFO - TEST-INFO | 1675: exit 0 22:38:35 INFO - Browser initialized. 22:38:35 INFO - Running cycle 1/1 for kraken test... 22:38:35 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpE5XPD_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:38:47 INFO - PROCESS | 1678 | RSS: Main: 254312448 22:38:47 INFO - PROCESS | 1678 | 22:38:49 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 22:38:50 INFO - PROCESS | 1678 | RSS: Main: 266768384 22:38:50 INFO - PROCESS | 1678 | 22:38:52 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 22:38:53 INFO - PROCESS | 1678 | RSS: Main: 275783680 22:38:53 INFO - PROCESS | 1678 | 22:38:56 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 22:38:57 INFO - PROCESS | 1678 | RSS: Main: 278724608 22:38:57 INFO - PROCESS | 1678 | 22:38:59 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 22:39:00 INFO - PROCESS | 1678 | RSS: Main: 280768512 22:39:00 INFO - PROCESS | 1678 | 22:39:02 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:39:02 INFO - PROCESS | 1678 | RSS: Main: 281522176 22:39:02 INFO - PROCESS | 1678 | 22:39:05 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 22:39:06 INFO - PROCESS | 1678 | RSS: Main: 282341376 22:39:06 INFO - PROCESS | 1678 | 22:39:09 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 22:39:09 INFO - PROCESS | 1678 | RSS: Main: 282259456 22:39:09 INFO - PROCESS | 1678 | 22:39:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 22:39:12 INFO - PROCESS | 1678 | RSS: Main: 282329088 22:39:12 INFO - PROCESS | 1678 | 22:39:14 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:39:15 INFO - PROCESS | 1678 | RSS: Main: 281493504 22:39:15 INFO - PROCESS | 1678 | 22:39:17 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:39:17 INFO - PROCESS | 1678 | RSS: Main: 281583616 22:39:17 INFO - PROCESS | 1678 | 22:39:19 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:39:20 INFO - PROCESS | 1678 | RSS: Main: 281550848 22:39:20 INFO - PROCESS | 1678 | 22:39:23 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:39:23 INFO - PROCESS | 1678 | RSS: Main: 281989120 22:39:23 INFO - PROCESS | 1678 | 22:39:26 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:39:26 INFO - PROCESS | 1678 | RSS: Main: 281870336 22:39:26 INFO - PROCESS | 1678 | 22:39:28 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 22:39:29 INFO - PROCESS | 1678 | RSS: Main: 283721728 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | __start_tp_report 22:39:29 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 22:39:29 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 22:39:29 INFO - PROCESS | 1678 | |i|pagename|runs| 22:39:29 INFO - PROCESS | 1678 | |0;ai-astar;115;109;117;115;117;129;117;117;116;114 22:39:29 INFO - PROCESS | 1678 | |1;audio-beat-detection;154;145;149;154;116;143;138;117;158;123 22:39:29 INFO - PROCESS | 1678 | |2;audio-dft;196;205;197;199;195;209;259;269;239;201 22:39:29 INFO - PROCESS | 1678 | |3;audio-fft;56;72;98;101;109;143;55;58;57;58 22:39:29 INFO - PROCESS | 1678 | |4;audio-oscillator;81;82;125;81;80;82;119;81;83;116 22:39:29 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;88;87;88;84;89;86;93;128;88;87 22:39:29 INFO - PROCESS | 1678 | |6;imaging-darkroom;94;96;95;95;95;115;115;95;94;93 22:39:29 INFO - PROCESS | 1678 | |7;imaging-desaturate;92;96;94;93;96;92;92;96;90;93 22:39:29 INFO - PROCESS | 1678 | |8;json-parse-financial;56;55;57;56;59;77;82;91;65;56 22:39:29 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;68;67;70;70;78;75;70;69;71;70 22:39:29 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;86;84;90;104;87;81;81;83;88;84 22:39:29 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;141;138;126;139;137;139;135;123;144;121 22:39:29 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;154;140;142;180;179;174;143;142;121;118 22:39:29 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;58;85;97;95;71;71;70;68;85;92 22:39:29 INFO - PROCESS | 1678 | __end_tp_report 22:39:29 INFO - PROCESS | 1678 | __start_cc_report 22:39:29 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,945 22:39:29 INFO - PROCESS | 1678 | __end_cc_report 22:39:29 INFO - PROCESS | 1678 | __startTimestamp1458970769074__endTimestamp 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | ------- Summary: start ------- 22:39:29 INFO - PROCESS | 1678 | Number of tests: 14 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:116.60 Median:117.00 stddev:4.99 (4.3%) stddev-sans-first:5.26 22:39:29 INFO - PROCESS | 1678 | Values: 115.0 109.0 117.0 115.0 117.0 129.0 117.0 117.0 116.0 114.0 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:147.00 stddev:15.73 (10.7%) stddev-sans-first:15.81 22:39:29 INFO - PROCESS | 1678 | Values: 154.0 145.0 149.0 154.0 116.0 143.0 138.0 117.0 158.0 123.0 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:216.90 Median:207.00 stddev:28.02 (13.5%) stddev-sans-first:28.68 22:39:29 INFO - PROCESS | 1678 | Values: 196.0 205.0 197.0 199.0 195.0 209.0 259.0 269.0 239.0 201.0 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:80.70 Median:57.50 stddev:30.43 (52.9%) stddev-sans-first:30.93 22:39:29 INFO - PROCESS | 1678 | Values: 56.0 72.0 98.0 101.0 109.0 143.0 55.0 58.0 57.0 58.0 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:81.00 stddev:18.77 (23.2%) stddev-sans-first:19.40 22:39:29 INFO - PROCESS | 1678 | Values: 81.0 82.0 125.0 81.0 80.0 82.0 119.0 81.0 83.0 116.0 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:91.80 Median:88.00 stddev:12.93 (14.7%) stddev-sans-first:13.64 22:39:29 INFO - PROCESS | 1678 | Values: 88.0 87.0 88.0 84.0 89.0 86.0 93.0 128.0 88.0 87.0 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:98.70 Median:95.00 stddev:8.63 (9.1%) stddev-sans-first:8.98 22:39:29 INFO - PROCESS | 1678 | Values: 94.0 96.0 95.0 95.0 95.0 115.0 115.0 95.0 94.0 93.0 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:93.40 Median:93.50 stddev:2.07 (2.2%) stddev-sans-first:2.13 22:39:29 INFO - PROCESS | 1678 | Values: 92.0 96.0 94.0 93.0 96.0 92.0 92.0 96.0 90.0 93.0 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:62.00 stddev:13.13 (21.2%) stddev-sans-first:13.47 22:39:29 INFO - PROCESS | 1678 | Values: 56.0 55.0 57.0 56.0 59.0 77.0 82.0 91.0 65.0 56.0 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:70.00 stddev:3.29 (4.7%) stddev-sans-first:3.33 22:39:29 INFO - PROCESS | 1678 | Values: 68.0 67.0 70.0 70.0 78.0 75.0 70.0 69.0 71.0 70.0 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:85.00 stddev:6.71 (7.9%) stddev-sans-first:7.11 22:39:29 INFO - PROCESS | 1678 | Values: 86.0 84.0 90.0 104.0 87.0 81.0 81.0 83.0 88.0 84.0 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:138.50 stddev:8.01 (5.8%) stddev-sans-first:8.13 22:39:29 INFO - PROCESS | 1678 | Values: 141.0 138.0 126.0 139.0 137.0 139.0 135.0 123.0 144.0 121.0 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:148.50 stddev:22.29 (15.0%) stddev-sans-first:23.57 22:39:29 INFO - PROCESS | 1678 | Values: 154.0 140.0 142.0 180.0 179.0 174.0 143.0 142.0 121.0 118.0 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.20 Median:85.00 stddev:13.30 (15.6%) stddev-sans-first:11.68 22:39:29 INFO - PROCESS | 1678 | Values: 58.0 85.0 97.0 95.0 71.0 71.0 70.0 68.0 85.0 92.0 22:39:29 INFO - PROCESS | 1678 | -------- Summary: end -------- 22:39:29 INFO - PROCESS | 1678 | 22:39:29 INFO - TEST-INFO | 1678: exit 0 22:39:29 INFO - TEST-OK | kraken | took 58043ms 22:39:29 INFO - SUITE-END | took 1169s 22:39:30 INFO - Completed test suite (00:19:29) 22:39:30 INFO - javascript benchmark 22:39:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2939.4562006028887, 2943.8233705977655, 3548.5032095506635, 3561.590417102034, 3636.909077273068, 5893.852653683654, 5894.292684877821, 5921.703914804259, 5922.132886153908, 5925.940740592593, 5762.279715035621, 5815.273090863642, 5860.208871802305, 5905.557083218765, 5945.316288626809, 5259.526642602165, 5322.7072511012075, 5342.118550439173, 5363.597730170233, 5415.891682166354, 5368.677879327252, 5387.4612538746005, 5412.91880621789, 5440.591955603326, 5457.126859702448, 5226.033183860998, 5254.52709256165, 5315.176147697113, 5346.224797404393, 5349.358077030781, 5336.092864213093, 5339.519443250126, 5342.973285133588, 5368.087425137736, 5437.157240627669, 5062.721550314731, 5248.291480650139, 5308.761105750251, 5352.384475785296, 5359.410464848864, 5826.504747096502, 5836.416358364172, 5880.7353669085, 5888.764449422018, 5889.381614930414, 6184.938150618481, 6225.284092329395, 6229.781957631507, 6237.157983672191, 6246.500279977591, 6165.815025549241, 6192.195014648112, 6259.186305780219, 6271.27880293763, 6272.843178920518, 6019.819405417845, 6031.60794548353, 6036.8188954331445, 6039.396060394013, 6096.695165241765, 6322.620642761449, 6356.618602883842, 6360.618362898241, 6373.298937116913, 6385.2656944451055, 6113.841195312687, 6168.1056246844855, 6212.565120441525, 6258.436740693269, 6259.499240060784, 6111.19673459643, 6192.195014648157, 6251.218597675291, 6278.905816412757, 6288.811335659938, 6159.630422174594, 6210.813675589739, 6235.127082208494, 6243.37566243372, 6257.812265632038, 5199.324087868553, 6166.0, 6173.938260617337, 6219.440250377488, 6228.813135605939, 4934.18585933317, 4970.502949705001, 4980.90038199234, 4987.975060124676, 4993.900121997613, 3824.847006119724, 4504.0, 4508.32375143731, 4522.751248681288, 4535.251683472256, 5833.708314584339, 5932.3177834548715, 5961.105834124829, 5966.76132954677, 6053.606515576562, 6237.844053898689, 6242.968785156045, 6251.218597675291, 6256.468200202943, 6448.967755161194, 5872.4421179988685, 5990.272885793367, 6006.579539432198, 6031.306399764083, 6059.909101363483, 5440.292761940922, 5525.972370138124, 5532.253145825262, 5564.805231816867, 5569.777208911598, 6498.675066246763, 6523.673816309166, 6554.180727409074, 6558.606483611094, 6568.080468734381, 6069.787557435468, 6170.598911070766, 6220.284667263141, 6259.78090766821, 6267.780627678009, 6391.424771770563, 6449.3873082057125, 6515.73937042513, 6526.314736952741, 6528.706208220737, 5589.413111623384, 6121.816345509642, 6166.630002199882, 6184.226971628546, 6204.069389591597, 6142.262928448615, 6152.261728592597, 6290.182276304051, 6300.558960872695, 6305.8108256752375, 6120.2947619997085, 6179.011358182669, 6191.907121393093, 6200.627962322275, 6203.666211764492, 5953.940460595339, 6157.9384206157365, 6161.84595385119, 6169.629822210682, 6180.381961803783, 6048.425399587032, 6088.726007329769, 6112.1995365628145, 6135.478484328882, 6161.44546990773, 6159.907601386072, 6176.66028368444, 6176.907346389898, 6210.937890621036, 6211.099390588249, 6180.289266734383, 6191.071339299141, 6198.535109866688, 6209.813705588839, 6227.657478838526], "unit": "score", "name": "dojo.html", "value": 5792.114651569068}, {"lowerIsBetter": false, "replicates": [436.67031391299565, 506.80488012115336, 574.7557288152536, 602.3855667219439, 623.937606239376, 36878.815605922, 37496.62503374965, 37503.06242343943, 37550.8122459388, 37623.81188094059, 38207.61792382082, 38748.80625596868, 38849.83450496483, 38898.8055059725, 38905.02737431566, 9190.770230744218, 9431.056894310548, 9437.0, 9447.196988256006, 9518.0, 9203.263738900905, 9315.813683726321, 9328.860067098998, 9329.253659707207, 9397.389169703947, 8216.383771217153, 9286.489243091628, 9305.302102342317, 9398.201152902011, 9400.153986141246, 9405.85891211629, 9483.573239204217, 9489.288303377274, 9500.572474238676, 9510.714678559654, 8211.548364839931, 9586.137247647675, 9591.136797688172, 9593.280503962162, 9620.470874101922, 38107.61892381068, 38358.04104897372, 38415.0, 38547.0, 38704.22591548153, 3143.167060728909, 3171.8414079295944, 3175.412548678502, 3223.0, 3404.268082362304, 23723.525529489314, 26232.213033609023, 27832.30419239515, 27855.16434506968, 28132.01537946162, 2488.9875550622314, 2707.10665480391, 2721.265258380246, 2807.985960070207, 2886.2495751104652, 353972.0, 420174.0, 423748.0, 424156.0, 427491.0, 57331.0, 64014.399640009375, 64233.678831605546, 64347.35652643508, 64618.35381646217, 70156.29843701498, 71322.9301560477, 72039.27960720325, 73221.2677873225, 73681.6315918417, 13884.375203115884, 16383.508494745176, 16760.245788939526, 16889.577760556083, 16890.662186756195, 12563.874361256454, 12979.156354837094, 12981.870181298254, 13034.674133146747, 13041.152325098838, 20450.693239601416, 20707.964601770153, 20793.96030198484, 20850.853203073977, 21511.0, 7666.731664391719, 9261.30540209487, 9267.053918677153, 9271.490068046322, 9280.443173409618, 939.6805086270564, 978.4178413843752, 986.1026465915982, 989.8861630912393, 1017.4709151241314, 25040.749592504206, 28967.986120485682, 29206.707932920825, 29619.407611847644, 29808.552871706943, 1053.963111291101, 1160.2980196980704, 1182.6747644397688, 1188.536470776398, 1223.5839814463125, 14726.852731472762, 14894.70210595782, 14910.776338354934, 14920.12573307042, 15200.239988000776, 509435.0, 512726.0, 514343.0, 515773.0, 521323.0, 55340.72329638326, 56651.15023274654, 56767.432325676215, 57400.42599573951, 57491.42508574944, 1440.9279536023157, 1441.6467965348347, 1452.4625888421351, 1457.9052361596462, 1466.113001633996, 28755.13734587966, 28803.44779424955, 28904.7109528902, 29211.7078829209, 29612.815487380263, 48640.0, 49567.00865982588, 49620.75189624029, 49913.0, 50016.499835002636, 498176.0, 509692.4515377548, 514685.0, 516309.0, 516662.0, 33015.17462063468, 33017.834910825295, 33071.66928330686, 33479.66520334766, 33677.49483757697, 43741.34387984119, 43925.0, 44310.0, 44796.55203447924, 45086.32370514511, 35935.92192234237, 36685.0, 36831.63168368282, 37041.25917481689, 37201.511939523196, 36473.817630911675, 36658.8167059163, 36764.816175920016, 37157.81421092877, 37233.44149837809, 34889.47665785066, 35595.288094237454, 36138.0, 36471.45292820557, 36869.0, 30047.248818779706, 31810.705554749813, 32043.839780801878, 32370.0, 32491.512627311084, 24026.15908443196, 24152.0, 24236.272911812674, 24560.0, 24575.508489829746], "unit": "score", "name": "ext.html", "value": 19563.266798512686}, {"lowerIsBetter": false, "replicates": [361.2504054087767, 362.262795211744, 370.62011438275766, 376.2681584318498, 376.9811509424528, 19986.800131998676, 20223.39329820106, 20749.273775417863, 21272.89363553184, 21558.89220553899, 20616.896915515437, 20956.476088097806, 21088.36734897952, 21218.363449096552, 21274.042668079936, 5624.831255062344, 5874.5594080443925, 5883.352831188566, 5885.146653735227, 5887.058070708687, 5444.183372494118, 5654.406287339832, 5695.373508914016, 5756.8272951811305, 5759.510441612468, 5649.576281778863, 5676.687782171979, 5706.9429305707035, 5712.514436272901, 5720.056190728525, 5331.493508116742, 5447.782088716466, 5477.1510415885405, 5728.914066289009, 5736.598438109334, 5004.424491183488, 5009.599232061426, 5013.0725815723845, 5029.371328583927, 5038.067957427887, 25536.744632553808, 25918.870405647853, 26120.73879261202, 26176.9529218831, 26214.606780898303, 2114.080375036864, 2215.634420320645, 2309.8036666883336, 2333.0667732906804, 2581.7031041430287, 9341.392809467363, 14833.629159270997, 15055.47305844301, 15129.470468533658, 15401.922990384975, 1615.515345396388, 1719.759233707282, 1808.1501694203835, 1831.6611426886068, 1936.6514027475048, 104949.47525262325, 107338.8532229351, 108030.0, 108597.91402086036, 108787.0, 9317.627294908129, 9574.425534467955, 11167.218294719292, 11255.66233013011, 11296.943515282372, 13514.662133446742, 13542.45830166802, 13560.0, 13568.457261709618, 13606.727865442635, 8342.62458189383, 8474.788130296793, 8499.640057590756, 8573.314134869195, 8585.18440748128, 8530.87203691945, 8542.82914341722, 8608.741737747878, 8645.481271123752, 8715.738527844174, 3707.6107008763693, 4394.659628813179, 4416.889577760582, 4442.955570444255, 4448.733076015449, 1650.5378494021693, 1885.9528511787041, 1917.3864363403857, 1926.5280006398523, 1938.7188857615567, 928.6563971330651, 1001.9549120289604, 1008.6419321141036, 1016.3546148195949, 1032.3031953431555, 20485.48786280325, 20602.0, 20868.26961056386, 20915.79084209169, 20981.895090524755, 877.9078196789245, 930.469632309577, 953.7806304549993, 1030.4178139351243, 1063.409807556798, 10954.835677464844, 11205.271657342246, 11257.0, 11276.267042642203, 11278.436078196057, 592914.0, 596842.0, 605245.0, 610205.0, 611658.0, 91022.0, 101791.0, 102788.0, 110411.44794276138, 114408.99137060493, 989.5942663508071, 999.8102258312584, 1024.0, 1026.6714651311659, 1034.8551202831609, 18522.444326670222, 18742.53143671419, 18825.623487530447, 18836.717449238, 19139.330123445612, 48912.0, 50489.990200196524, 50577.49422505728, 51595.96808063742, 52151.47848521466, 69962.0, 72188.19529511804, 72753.0, 73120.51596130205, 73667.6316618435, 6023.909641355295, 6561.934380656132, 6916.997035429734, 7765.495242809199, 7806.41451891099, 8988.280937525113, 10475.371477711362, 11614.535418583162, 12462.252264864137, 12916.612501624966, 11121.555137794398, 11149.665510034712, 11188.440577970907, 11379.089672825989, 11489.885101148882, 9178.586963586522, 10657.307275027099, 11031.282966607145, 11432.256903301259, 11672.840524502994, 9130.269578433577, 11223.55105795759, 11402.087832973508, 11441.199116061796, 11562.710932226762, 7943.801404964922, 7944.04671439431, 7959.721409750631, 7986.720464783704, 8052.959735201521, 9392.925430210293, 11427.200095993201, 11477.36874471912, 11483.885161148282, 11732.530698771954], "unit": "score", "name": "jquery.html", "value": 9393.669067992256}, {"lowerIsBetter": false, "replicates": [1589.3086507369296, 1593.7370333894905, 1693.6443346897152, 1850.888946663201, 1863.1522657190978, 8073.031236251643, 8778.824423511525, 8817.162369574888, 9054.04932482089, 9068.727938161857, 8789.25291350236, 8801.471911685303, 8831.249343805768, 8882.77793055174, 8921.286297096232, 2401.1955994741784, 2503.674522312106, 2505.924822255335, 2511.5981442969037, 2518.6725725655638, 2453.7300896901324, 2500.3499090236487, 2508.385445565839, 2508.636247744076, 2510.5230006298834, 2475.938101547458, 2483.552960467115, 2527.772500474957, 2536.087008676875, 2548.3501707064675, 2490.0786708917726, 2523.356544081266, 2523.7602427769425, 2529.481456301472, 2532.050481069599, 2175.695402643631, 2482.354587807183, 2500.8499490030476, 2514.170323793144, 2540.2506260653154, 8965.820683586291, 8968.327375446803, 8982.685606003824, 9029.729108126767, 9036.322275829274, 5497.45025497451, 5583.972080139573, 5604.467575580314, 5608.691521966291, 5662.207290979266, 3536.381133301662, 3600.837962291677, 3670.2475992421755, 3676.8713095041544, 3691.206390626028, 1011.949402529878, 1052.5000624703205, 1055.8732952045727, 1057.3074636113358, 1058.2327812336073, 12114.757704845942, 12144.02847772185, 12180.81728774069, 12231.816522752166, 12246.632601021984, 4230.598093181143, 4884.3650325457465, 4932.482089380635, 4993.177490216045, 5032.874178145503, 10058.849117263248, 10089.798204036026, 10192.286539942133, 10279.17766578672, 10284.897151028543, 5539.14143307788, 5542.972285138549, 5570.498655121059, 5585.553155747531, 5594.776208951678, 4535.750533720677, 4879.072976134523, 4993.775280112403, 5036.068327359377, 5044.520770526794, 3445.6554344565843, 3852.9807350963065, 3952.130531283113, 3976.4631774710624, 3995.5005624296964, 1198.3828328410875, 1326.37660299659, 1338.5248236875768, 1340.5107135895328, 1348.4538761801487, 1127.9548818047351, 1140.4696815980442, 1152.619635520293, 1311.4098655605017, 1389.1456754096157, 8073.6770529178175, 8229.382796290183, 8264.793380165544, 8394.79013024667, 8434.57827108642, 528.197140346671, 533.4318950317898, 534.7914313417771, 540.3326891289255, 542.0243561589202, 6244.375562443719, 6250.281217659936, 6290.685465726695, 6305.936940630627, 6327.905081423783, 9230.58462369195, 9657.613695452103, 10720.303180293256, 10981.725456863482, 11075.667729968114, 10416.166706663449, 10573.20700947432, 10656.893431065746, 10700.090492308242, 10746.399082454893, 6711.832204194934, 8398.664053437795, 8414.873776893352, 8473.915260847436, 8543.316534677211, 7935.2064793520185, 7979.680812767657, 7980.241877021674, 7998.800029999296, 8054.959725201336, 8007.919920800718, 9679.758006049906, 9710.368826026286, 9717.27120465982, 9764.853527196956, 9615.9038409615, 9904.405735655884, 9910.950445247727, 10034.996500349907, 10165.491725413847, 6825.078614387193, 7337.156227033959, 7541.283578060075, 7560.697572097055, 7618.542887426772, 8395.83208335842, 8410.53742044169, 8420.915790842013, 8437.620307086074, 8481.27909127731, 7381.44639152055, 7543.73596924105, 7590.886136707843, 7591.962040189764, 7632.19861914491, 7351.70593176267, 7361.447891408059, 7362.705491780269, 7432.2567743225245, 7467.850642987001, 7874.251946065115, 7917.089534703583, 7931.643076061707, 7934.801629959297, 7953.085395179397, 7069.045678833291, 7163.31948464895, 7177.856442871218, 7215.71137154508, 7229.024081748897, 7213.242609526134, 7244.094488188976, 7260.419166466776, 7292.562446253241, 7298.890516642361], "unit": "score", "name": "mootools.html", "value": 4889.69712619132}, {"lowerIsBetter": false, "replicates": [331.39354980385895, 331.76444724245783, 337.421322432029, 339.4178983044079, 340.6168060931452, 6792.049113124167, 6833.965830170855, 6845.452363810896, 6865.347791959762, 6866.382025617693, 6677.065210870482, 6688.732450701978, 6692.2303935047485, 6785.864282714343, 6787.389134977851, 4774.283857421397, 4838.637102217348, 4975.179095449264, 4989.525995030466, 5032.421271553772, 4955.975220123894, 4974.452810190876, 4978.850634480953, 4980.35648236083, 4987.426445958725, 4873.098476781789, 4893.730844803535, 4916.065947469987, 4919.975400123012, 4923.679960802554, 4916.729579873106, 4971.0803501352, 4974.950250497485, 4988.176950803131, 4992.350994370745, 3706.8517259309597, 3853.689745486548, 3861.9227615447817, 4273.102648443831, 4283.550227226127, 6357.4914006879335, 6535.836604084889, 6626.039224312448, 6639.0, 6644.970029645413, 4801.231802911552, 5870.943230218559, 5906.793262235844, 5915.645061296336, 5917.319508256563, 7267.055282813253, 7271.381932535741, 7290.635468226567, 7301.0, 7303.196648368676, 4775.498572649891, 4786.952130478686, 4794.113089078532, 4801.255805350142, 4807.879803004917, 7665.540067595962, 7704.499207551547, 7704.6918123275, 7709.922900770976, 7719.614019299069, 4378.277584198571, 4744.240921452551, 4818.204996175662, 4840.491748366371, 4852.757362131879, 4147.6474499667265, 4918.754062296871, 4943.110240156734, 4951.529604687549, 4954.405471343462, 5851.61964472308, 5893.675847828325, 5897.233359663216, 5911.349751527328, 5921.585489015728, 7341.963290183622, 7344.779656610311, 7357.3378395943555, 7358.926410735824, 7365.226651201547, 1614.5237155039292, 1660.3192690996634, 1703.131402984462, 1713.7600735896985, 1729.135432283858, 951.4814426137772, 1093.6500319897716, 1103.2938919091787, 1114.3481063577897, 1120.0815331428314, 5161.225816127536, 5803.941960580424, 6696.7656132035145, 6702.698378572976, 6711.932880671131, 7450.627468626547, 7455.627218639046, 7457.067866516685, 7461.291177338144, 7468.10382754073, 6660.83347916306, 6678.9332106679285, 6681.699323530453, 6709.0, 6720.126383570202, 3461.567304086989, 3982.6415622593527, 3998.020484981198, 4013.6387725104883, 4017.738846974937, 7472.626368681653, 7810.336121429628, 7814.68741250355, 7815.29662330393, 7856.33221176195, 7641.923580764233, 7650.579218142944, 7665.156832748393, 7683.769486915289, 7710.0, 7770.0, 7794.727184548514, 7800.297973182441, 7818.6090695465, 7836.216378362232, 7369.152547456896, 7397.556146631219, 7401.0, 7411.2588741125455, 7421.183669796426, 5818.010938140611, 6877.346652068046, 7347.559146451016, 7541.472096953161, 7616.200298968529, 8091.231333023354, 8091.90759247494, 8096.109427963037, 8132.2680958714, 8145.470544414594, 3868.9419658705706, 4743.525647435229, 4745.38310019709, 4758.405199350082, 4762.857114286577, 7372.0, 7681.884771728317, 7688.346490548366, 7698.191689872707, 7705.30652241301, 7338.376238019615, 7374.963125184339, 7378.815529611803, 7380.0, 7418.851622967619, 6617.8014659560295, 6725.327467253235, 7346.375558077623, 7349.742759003409, 7432.591207483641, 7181.497295189287, 7211.639418029183, 7217.566945983048, 7222.133343998754, 7244.673989670372, 7057.682404291922, 7365.0, 7391.186969433251, 7392.630368481662, 7445.255474452511, 7203.927960720326, 7212.350888420067, 7233.710651573878, 7241.456890733321, 7256.96371518139], "unit": "score", "name": "prototype.html", "value": 5287.820768693528}, {"lowerIsBetter": false, "replicates": [643.1960049937578, 677.4715721737044, 686.1114856261141, 689.2211800665248, 690.2441826200312, 13020.348982550859, 13824.239666818321, 13910.234937078456, 14063.29683515824, 15440.536783896501, 14555.490557830479, 14561.126332420063, 14604.415823367079, 14659.340329685163, 14747.705045899102, 874.2437791310502, 894.9149830766083, 916.9128932751378, 921.3136213520903, 921.4609453469728, 787.5747096567875, 887.7114937645259, 900.275278400887, 912.2975309012056, 917.454114801692, 802.7837825694078, 930.3115694386139, 939.178219058324, 945.4563625915092, 945.7871978804783, 898.128815049401, 902.7111324376202, 908.6002159049997, 923.8845144356922, 950.5009869818332, 674.5514233035026, 677.5155763629028, 691.3881215124651, 696.7039008421401, 701.421327404888, 13072.673183170402, 14179.361928713233, 14337.49818756349, 14472.204028778413, 14486.42054317826, 11689.766204675943, 11841.40792960357, 11942.522299108025, 11960.0, 12106.515739370414, 9323.0, 9348.846703408875, 9415.858762118505, 9588.232941364744, 9597.808043839153, 3280.6883346082086, 3313.5692359993286, 3332.800031998088, 3358.529805827186, 3427.2288735034667, 57228.0, 73227.80316590564, 76383.6180819098, 77208.0, 77255.22744772593, 8524.488530688179, 8530.189631984951, 8656.740297791077, 8719.520426376483, 8835.602397891982, 18983.81016189848, 19034.85924822389, 19045.333413330743, 19046.0, 19100.713489297672, 6033.5173186145, 6748.257691653914, 6980.546264492792, 7033.9296607033275, 7039.979203015534, 3803.1823158020607, 3847.5960024197616, 3865.7873816939777, 3880.1463677990796, 3884.1454879926373, 3332.3501917126414, 3382.5095361172494, 3382.9323413531592, 3387.7289816814596, 3387.983060084684, 605.8636806718541, 608.4068033667139, 616.8457885528618, 624.3257282135284, 631.6904716688789, 574.3309044962572, 589.3252226200976, 592.3572923378183, 609.430182779103, 620.5656040771388, 7750.14748377678, 7790.883136752953, 7874.330681891989, 7989.600519973978, 7995.2804247618, 499.17885079045493, 542.5984771269233, 576.8384852241379, 577.431230238215, 603.4900509069829, 2823.901163459269, 3349.246419555629, 3502.6322236164838, 3753.756005859665, 3843.2889915365745, 86312.0, 90620.6406903897, 92289.61565576521, 93066.53466732758, 93811.0, 79524.80712789313, 79894.0, 80049.0, 80979.5951020253, 81119.18880811235, 71231.0, 72088.0, 74772.62613686897, 75070.6246468775, 75136.4972700532, 6424.51816113784, 7879.409044321585, 8267.710630127916, 8333.041700204554, 8338.70814521513, 49480.51558453252, 50630.74684626701, 50984.235236472225, 51733.482665172865, 54272.0, 65983.0, 71164.0, 72246.0, 73542.63228684037, 74799.0, 10472.581096756348, 10474.68575942723, 10493.108085812792, 10537.209709271989, 10808.891911081104, 11336.886631133582, 11593.536258549564, 11835.0, 11934.701632459259, 12089.758204835678, 10768.300060496043, 10772.138228941823, 11042.889571104186, 11192.552297907992, 11195.552177913118, 10452.738681532719, 10585.994330538586, 10588.41763702973, 10706.250562460553, 10788.784224315626, 10406.01142891424, 10470.633527826489, 10715.678529644123, 10724.785504290026, 10995.725106872393, 9255.35212535143, 9295.907040929504, 9302.906970930475, 9677.854832177381, 9709.757256068373, 7525.623718813928, 8650.264727498234, 8866.290696744116, 9145.413870246084, 9162.358634895494], "unit": "score", "name": "yui.html", "value": 6641.227980998259}], "name": "dromaeo_css", "value": 7533.424704627308}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 117.0, 115.0, 117.0, 129.0, 117.0, 117.0, 116.0, 114.0], "unit": "score", "name": "ai-astar", "value": 116.6}, {"lowerIsBetter": true, "replicates": [154.0, 145.0, 149.0, 154.0, 116.0, 143.0, 138.0, 117.0, 158.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 139.7}, {"lowerIsBetter": true, "replicates": [196.0, 205.0, 197.0, 199.0, 195.0, 209.0, 259.0, 269.0, 239.0, 201.0], "unit": "score", "name": "audio-dft", "value": 216.9}, {"lowerIsBetter": true, "replicates": [56.0, 72.0, 98.0, 101.0, 109.0, 143.0, 55.0, 58.0, 57.0, 58.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 125.0, 81.0, 80.0, 82.0, 119.0, 81.0, 83.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 93.0}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 88.0, 84.0, 89.0, 86.0, 93.0, 128.0, 88.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.8}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 95.0, 95.0, 95.0, 115.0, 115.0, 95.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 98.7}, {"lowerIsBetter": true, "replicates": [92.0, 96.0, 94.0, 93.0, 96.0, 92.0, 92.0, 96.0, 90.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 93.4}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 57.0, 56.0, 59.0, 77.0, 82.0, 91.0, 65.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 65.4}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 70.0, 70.0, 78.0, 75.0, 70.0, 69.0, 71.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.8}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 90.0, 104.0, 87.0, 81.0, 81.0, 83.0, 88.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [141.0, 138.0, 126.0, 139.0, 137.0, 139.0, 135.0, 123.0, 144.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 134.3}, {"lowerIsBetter": true, "replicates": [154.0, 140.0, 142.0, 180.0, 179.0, 174.0, 143.0, 142.0, 121.0, 118.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [58.0, 85.0, 97.0, 95.0, 71.0, 71.0, 70.0, 68.0, 85.0, 92.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 79.2}], "name": "kraken", "value": 1516.6}]} 22:39:30 INFO - Return code: 0 22:39:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:39:30 ERROR - # TBPL SUCCESS # 22:39:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:39:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:39:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:39:30 INFO - 2016-03-25 22:39:30.350 screenresolution[1683:10570] starting screenresolution argv=screenresolution get 22:39:30 INFO - 2016-03-25 22:39:30.352 screenresolution[1683:10570] Display 0: 1600x1200x32@60 22:39:30 INFO - 2016-03-25 22:39:30.358 screenresolution[1684:10573] starting screenresolution argv=screenresolution list 22:39:30 INFO - Available Modes on Display 0 22:39:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:39:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:39:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:39:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:39:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:39:30 INFO - Intel Iris: 22:39:30 INFO - Chipset Model: Intel Iris 22:39:30 INFO - Type: GPU 22:39:30 INFO - Bus: Built-In 22:39:30 INFO - VRAM (Dynamic, Max): 1536 MB 22:39:30 INFO - Vendor: Intel (0x8086) 22:39:30 INFO - Device ID: 0x0a2e 22:39:30 INFO - Revision ID: 0x0009 22:39:30 INFO - Displays: 22:39:30 INFO - Display: 22:39:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:39:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:39:30 INFO - Display Serial Number: 1600x1200 60 22:39:30 INFO - Main Display: Yes 22:39:30 INFO - Mirror: Off 22:39:30 INFO - Online: Yes 22:39:30 INFO - Rotation: Supported 22:39:30 INFO - Return code: 0 22:39:30 INFO - Running post-action listener: _resource_record_post_action 22:39:30 INFO - Running post-run listener: _resource_record_post_run 22:39:31 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 39798272; Write bytes: 706861056; Read time: 424; Write time: 1888 22:39:31 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 405780992; Write bytes: 394307072; Read time: 30314; Write time: 698 22:39:31 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 32693760; Write bytes: 299764224; Read time: 336; Write time: 1145 22:39:31 INFO - Running post-run listener: _upload_blobber_files 22:39:31 INFO - Blob upload gear active. 22:39:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:39:31 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 22:39:31 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'] 22:39:31 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 22:39:32 INFO - (blobuploader) - INFO - Open directory for files ... 22:39:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:39:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:39:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:33 INFO - (blobuploader) - INFO - Done attempting. 22:39:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:39:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:39:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:34 INFO - (blobuploader) - INFO - Done attempting. 22:39:34 INFO - (blobuploader) - INFO - Iteration through files over. 22:39:34 INFO - Return code: 0 22:39:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:39:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:39:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9bbf05ea06ec8641f9f92acc076261cbc73ae54d4394a884e2c95b8faceb615ecce587823ead2bb977d6fb38f5fa8d2cfe12d2fb582aadfb80e93c9457bd688", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ec91a775f245b1da8438236fe9e1e0ecf5f3d8865f6719de25a4d0d9e27a3aed6b621d9803c40a2f0e3f5bbe9d376a907ba79cb7bc6478ad20b6a3809ef8e56"} 22:39:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:39:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:39:34 INFO - Contents: 22:39:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9bbf05ea06ec8641f9f92acc076261cbc73ae54d4394a884e2c95b8faceb615ecce587823ead2bb977d6fb38f5fa8d2cfe12d2fb582aadfb80e93c9457bd688", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ec91a775f245b1da8438236fe9e1e0ecf5f3d8865f6719de25a4d0d9e27a3aed6b621d9803c40a2f0e3f5bbe9d376a907ba79cb7bc6478ad20b6a3809ef8e56"} 22:39:34 INFO - Running post-run listener: copy_logs_to_upload_dir 22:39:34 INFO - Copying logs to upload dir... 22:39:34 INFO - mkdir: /builds/slave/test/build/upload/logs 22:39:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1306.454654 ========= master_lag: 2.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2016-03-25 22:39:36.531609) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 22:39:36.535047) ========= 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.uho8VYpNB6/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.blMYX1R446/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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/b9bbf05ea06ec8641f9f92acc076261cbc73ae54d4394a884e2c95b8faceb615ecce587823ead2bb977d6fb38f5fa8d2cfe12d2fb582aadfb80e93c9457bd688", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ec91a775f245b1da8438236fe9e1e0ecf5f3d8865f6719de25a4d0d9e27a3aed6b621d9803c40a2f0e3f5bbe9d376a907ba79cb7bc6478ad20b6a3809ef8e56"} build_url:https://queue.taskcluster.net/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011091 build_url: 'https://queue.taskcluster.net/v1/task/H5aJ7cOfRW2zrxsug7olKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9bbf05ea06ec8641f9f92acc076261cbc73ae54d4394a884e2c95b8faceb615ecce587823ead2bb977d6fb38f5fa8d2cfe12d2fb582aadfb80e93c9457bd688", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ec91a775f245b1da8438236fe9e1e0ecf5f3d8865f6719de25a4d0d9e27a3aed6b621d9803c40a2f0e3f5bbe9d376a907ba79cb7bc6478ad20b6a3809ef8e56"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 22:39:36.567009) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 22:39:36.567787) ========= 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.uho8VYpNB6/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.blMYX1R446/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.004970 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 22:39:36.619935) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 22:39:36.620602) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 22:39:36.621332) ========= ========= Total master_lag: 2.57 =========