builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0143 starttime: 1458143257.06 results: success (0) buildid: 20160316064345 builduid: fb8c8e7bbeff41569631b284a0359cd5 revision: 360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:37.061076) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:37.061566) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:37.061867) ========= 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.vbJnTeHPQm/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.efxHMadUUw/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005631 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:37.087402) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:37.087689) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:37.104691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:37.104990) ========= 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.vbJnTeHPQm/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.efxHMadUUw/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005736 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:37.153305) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:37.153583) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:37.153949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:37.154233) ========= 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.vbJnTeHPQm/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.efxHMadUUw/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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-16 08:47:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-03-16 08:47:37 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187622 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:37.359772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:37.360202) ========= 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.vbJnTeHPQm/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.efxHMadUUw/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.025460 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:37.410217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-16 08:47:37.410788) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b --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 360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vbJnTeHPQm/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.efxHMadUUw/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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-16 08:47:37,488 truncating revision to first 12 chars 2016-03-16 08:47:37,488 Setting DEBUG logging. 2016-03-16 08:47:37,488 attempt 1/10 2016-03-16 08:47:37,488 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/360e21e14e09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 08:47:38,477 unpacking tar archive at: fx-team-360e21e14e09/testing/mozharness/ program finished with exit code 0 elapsedTime=1.232597 ========= master_lag: 0.38 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-16 08:47:39.019431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:39.019784) ========= echo 360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vbJnTeHPQm/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.efxHMadUUw/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b program finished with exit code 0 elapsedTime=0.006058 script_repo_revision: '360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:39.046250) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:39.046524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 08:47:39.060244) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-03-16 08:47:39.060536) ========= /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.vbJnTeHPQm/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.efxHMadUUw/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 08:47:39 INFO - MultiFileLogger online at 20160316 08:47:39 in /builds/slave/test 08:47:39 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 08:47:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:47:39 INFO - {'append_to_log': False, 08:47:39 INFO - 'base_work_dir': '/builds/slave/test', 08:47:39 INFO - 'blob_upload_branch': 'Fx-Team', 08:47:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:47:39 INFO - 'branch': 'Fx-Team', 08:47:39 INFO - 'buildbot_json_path': 'buildprops.json', 08:47:39 INFO - 'config_files': ('talos/mac_config.py',), 08:47:39 INFO - 'default_actions': ('clobber', 08:47:39 INFO - 'read-buildbot-config', 08:47:39 INFO - 'download-and-extract', 08:47:39 INFO - 'populate-webroot', 08:47:39 INFO - 'create-virtualenv', 08:47:39 INFO - 'install', 08:47:39 INFO - 'run-tests'), 08:47:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:47:39 INFO - 'download_minidump_stackwalk': True, 08:47:39 INFO - 'download_symbols': 'ondemand', 08:47:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:47:39 INFO - 'tooltool.py': '/tools/tooltool.py', 08:47:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:47:39 INFO - '/tools/misc-python/virtualenv.py')}, 08:47:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:47:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:47:39 INFO - 'installer_path': 'installer.exe', 08:47:39 INFO - 'log_level': 'info', 08:47:39 INFO - 'log_name': 'talos', 08:47:39 INFO - 'log_to_console': True, 08:47:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:47:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:47:39 INFO - 'opt_config_files': (), 08:47:39 INFO - 'pip_index': False, 08:47:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:47:39 INFO - 'cmd': ('bash', 08:47:39 INFO - '-c', 08:47:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:47:39 INFO - 'enabled': True, 08:47:39 INFO - 'halt_on_failure': False, 08:47:39 INFO - 'name': 'check_screen_resolution'},), 08:47:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:47:39 INFO - 'cmd': ('bash', 08:47:39 INFO - '-c', 08:47:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:47:39 INFO - 'enabled': True, 08:47:39 INFO - 'halt_on_failure': False, 08:47:39 INFO - 'name': 'check_screen_resolution'},), 08:47:39 INFO - 'run_cmd_checks_enabled': True, 08:47:39 INFO - 'sps_profile': False, 08:47:39 INFO - 'sps_profile_interval': 0, 08:47:39 INFO - 'suite': 'dromaeojs-e10s', 08:47:39 INFO - 'system_bits': '32', 08:47:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:47:39 INFO - 'title': 't-yosemite-r7-0143', 08:47:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:47:39 INFO - 'use_talos_json': True, 08:47:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:47:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:47:39 INFO - 'work_dir': 'build'} 08:47:39 INFO - ##### 08:47:39 INFO - ##### Running clobber step. 08:47:39 INFO - ##### 08:47:39 INFO - Running pre-action listener: _resource_record_pre_action 08:47:39 INFO - Running main action method: clobber 08:47:39 INFO - rmtree: /builds/slave/test/build 08:47:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:47:40 INFO - Running post-action listener: _resource_record_post_action 08:47:40 INFO - ##### 08:47:40 INFO - ##### Running read-buildbot-config step. 08:47:40 INFO - ##### 08:47:40 INFO - Running pre-action listener: _resource_record_pre_action 08:47:40 INFO - Running main action method: read_buildbot_config 08:47:40 INFO - Using buildbot properties: 08:47:40 INFO - { 08:47:40 INFO - "project": "", 08:47:40 INFO - "product": "firefox", 08:47:40 INFO - "script_repo_revision": "production", 08:47:40 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:47:40 INFO - "repository": "", 08:47:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:47:40 INFO - "buildid": "20160316064345", 08:47:40 INFO - "pgo_build": "False", 08:47:40 INFO - "basedir": "/builds/slave/test", 08:47:40 INFO - "buildnumber": 537, 08:47:40 INFO - "slavename": "t-yosemite-r7-0143", 08:47:40 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:47:40 INFO - "platform": "yosemite_r7", 08:47:40 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 08:47:40 INFO - "branch": "fx-team", 08:47:40 INFO - "repo_path": "integration/fx-team", 08:47:40 INFO - "revision": "360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b", 08:47:40 INFO - "stage_platform": "macosx64", 08:47:40 INFO - "builduid": "fb8c8e7bbeff41569631b284a0359cd5", 08:47:40 INFO - "slavebuilddir": "test" 08:47:40 INFO - } 08:47:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 08:47:40 INFO - Running post-action listener: _resource_record_post_action 08:47:40 INFO - ##### 08:47:40 INFO - ##### Running download-and-extract step. 08:47:40 INFO - ##### 08:47:40 INFO - Running pre-action listener: _resource_record_pre_action 08:47:40 INFO - Running main action method: download_and_extract 08:47:40 INFO - mkdir: /builds/slave/test/build/tests 08:47:40 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')]} 08:47:40 INFO - https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:47:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:47:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:47:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 08:47:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 08:47:42 INFO - Downloaded 1199 bytes. 08:47:42 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 08:47:42 INFO - Using the following test package requirements: 08:47:42 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:47:42 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:47:42 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 08:47:42 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:47:42 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 08:47:42 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:47:42 INFO - u'jsshell-mac.zip'], 08:47:42 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:47:42 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 08:47:42 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:47:42 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:47:42 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 08:47:42 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:47:42 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 08:47:42 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:47:42 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 08:47:42 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:47:42 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 08:47:42 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:42 INFO - https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:47:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:47:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:47:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 08:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 08:47:45 INFO - Downloaded 17854406 bytes. 08:47:45 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'] 08:47:45 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 08:47:48 INFO - Return code: 0 08:47:48 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 08:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:48 INFO - https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:47:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:47:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:47:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 08:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 08:47:51 INFO - Downloaded 17854406 bytes. 08:47:51 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'] 08:47:51 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 08:47:54 INFO - Return code: 0 08:47: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')]} 08:47:54 INFO - https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:47:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:47:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:47:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 08:47:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 08:47:55 INFO - Downloaded 10846462 bytes. 08:47:55 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'] 08:47:55 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 08:47:55 INFO - Return code: 0 08:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:55 INFO - https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:47:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:47:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:47:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 08:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 08:47:58 INFO - Downloaded 111197712 bytes. 08:47:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:47:58 INFO - mkdir: /builds/slave/test/properties 08:47:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:47:58 INFO - Writing to file /builds/slave/test/properties/build_url 08:47:58 INFO - Contents: 08:47:58 INFO - build_url:https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:47:59 INFO - Running post-action listener: _resource_record_post_action 08:47:59 INFO - Running post-action listener: set_extra_try_arguments 08:47:59 INFO - ##### 08:47:59 INFO - ##### Running populate-webroot step. 08:47:59 INFO - ##### 08:47:59 INFO - Running pre-action listener: _resource_record_pre_action 08:47:59 INFO - Running main action method: populate_webroot 08:47:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:47:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:47:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:47:59 INFO - '--tppagecycles', 08:47:59 INFO - '7'], 08:47:59 INFO - 'tests': ['tsvgm']}}, 08:47:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:47:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:47:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:47:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:47:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:47:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:47:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:59 INFO - 'talos_options': ['--e10s'], 08:47:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:59 INFO - 'tests': ['damp', 'tps']}, 08:47:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:59 INFO - 'talos_options': ['--e10s'], 08:47:59 INFO - 'tests': ['damp', 'tps']}, 08:47:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:47:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:47:59 INFO - 'other': {'tests': ['a11yr', 08:47:59 INFO - 'ts_paint', 08:47:59 INFO - 'tpaint', 08:47:59 INFO - 'sessionrestore', 08:47:59 INFO - 'sessionrestore_no_auto_restore', 08:47:59 INFO - 'tabpaint']}, 08:47:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:47:59 INFO - 'tests': ['a11yr', 08:47:59 INFO - 'ts_paint', 08:47:59 INFO - 'tpaint', 08:47:59 INFO - 'sessionrestore', 08:47:59 INFO - 'sessionrestore_no_auto_restore', 08:47:59 INFO - 'tabpaint']}, 08:47:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:47:59 INFO - 'tests': ['a11yr', 08:47:59 INFO - 'ts_paint', 08:47:59 INFO - 'tpaint', 08:47:59 INFO - 'sessionrestore', 08:47:59 INFO - 'sessionrestore_no_auto_restore', 08:47:59 INFO - 'tabpaint']}, 08:47:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:47:59 INFO - 'tests': ['a11yr', 08:47:59 INFO - 'ts_paint', 08:47:59 INFO - 'tpaint', 08:47:59 INFO - 'sessionrestore', 08:47:59 INFO - 'sessionrestore_no_auto_restore', 08:47:59 INFO - 'tabpaint']}, 08:47:59 INFO - 'other_l64': {'tests': ['a11yr', 08:47:59 INFO - 'ts_paint', 08:47:59 INFO - 'tpaint', 08:47:59 INFO - 'sessionrestore', 08:47:59 INFO - 'sessionrestore_no_auto_restore', 08:47:59 INFO - 'tabpaint']}, 08:47:59 INFO - 'other_nol64': {'tests': ['a11yr', 08:47:59 INFO - 'ts_paint', 08:47:59 INFO - 'tpaint', 08:47:59 INFO - 'sessionrestore', 08:47:59 INFO - 'sessionrestore_no_auto_restore', 08:47:59 INFO - 'tabpaint']}, 08:47:59 INFO - 'svgr': {'tests': ['tsvgx', 08:47:59 INFO - 'tsvgr_opacity', 08:47:59 INFO - 'tart', 08:47:59 INFO - 'tscrollx', 08:47:59 INFO - 'cart']}, 08:47:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:47:59 INFO - 'tests': ['tsvgx', 08:47:59 INFO - 'tsvgr_opacity', 08:47:59 INFO - 'tart', 08:47:59 INFO - 'tscrollx', 08:47:59 INFO - 'cart']}, 08:47:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:59 INFO - 'tests': ['tp5o']}, 08:47:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:59 INFO - 'talos_options': ['--e10s'], 08:47:59 INFO - 'tests': ['tp5o']}, 08:47:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:59 INFO - 'talos_options': ['--xperf_path', 08:47:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:59 INFO - 'tests': ['tp5n']}, 08:47:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:59 INFO - 'talos_options': ['--e10s', 08:47:59 INFO - '--xperf_path', 08:47:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:59 INFO - 'tests': ['tp5n']}}, 08:47:59 INFO - 'talos.zip': {'path': '', 08:47:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:47:59 INFO - Running post-action listener: _resource_record_post_action 08:47:59 INFO - ##### 08:47:59 INFO - ##### Running create-virtualenv step. 08:47:59 INFO - ##### 08:47:59 INFO - Running pre-action listener: _resource_record_pre_action 08:47:59 INFO - Running main action method: create_virtualenv 08:47:59 INFO - Creating virtualenv /builds/slave/test/build/venv 08:47:59 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 08:47:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:47:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:47:59 INFO - Using real prefix '/tools/python27' 08:47:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:48:00 INFO - Installing distribute.............................................................................................................................................................................................done. 08:48:03 INFO - Installing pip.................done. 08:48:03 INFO - Return code: 0 08:48:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:03 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 0x102262a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc9358dbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102106d30>, '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 0x101f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020fdb20>, '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.vbJnTeHPQm/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.efxHMadUUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 08:48:03 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 08:48:03 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 08:48:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbJnTeHPQm/Render', 08:48:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:03 INFO - 'HOME': '/Users/cltbld', 08:48:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:03 INFO - 'LOGNAME': 'cltbld', 08:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:03 INFO - 'MOZ_NO_REMOTE': '1', 08:48:03 INFO - 'NO_EM_RESTART': '1', 08:48:03 INFO - 'PAGER': '/bin/cat', 08:48:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:03 INFO - 'PWD': '/builds/slave/test', 08:48:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:03 INFO - 'SHELL': '/bin/bash', 08:48:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.efxHMadUUw/Listeners', 08:48:03 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 08:48:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:03 INFO - 'USER': 'cltbld', 08:48:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:03 INFO - 'XPC_FLAGS': '0x0', 08:48:03 INFO - 'XPC_SERVICE_NAME': '0', 08:48:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:03 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 08:48:03 INFO - Cleaning up... 08:48:03 INFO - Return code: 0 08:48:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:03 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 0x102262a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc9358dbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102106d30>, '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 0x101f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020fdb20>, '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.vbJnTeHPQm/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.efxHMadUUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 08:48:03 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 08:48:03 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 08:48:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbJnTeHPQm/Render', 08:48:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:03 INFO - 'HOME': '/Users/cltbld', 08:48:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:03 INFO - 'LOGNAME': 'cltbld', 08:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:03 INFO - 'MOZ_NO_REMOTE': '1', 08:48:03 INFO - 'NO_EM_RESTART': '1', 08:48:03 INFO - 'PAGER': '/bin/cat', 08:48:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:03 INFO - 'PWD': '/builds/slave/test', 08:48:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:03 INFO - 'SHELL': '/bin/bash', 08:48:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.efxHMadUUw/Listeners', 08:48:03 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 08:48:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:03 INFO - 'USER': 'cltbld', 08:48:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:03 INFO - 'XPC_FLAGS': '0x0', 08:48:03 INFO - 'XPC_SERVICE_NAME': '0', 08:48:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:03 INFO - Downloading/unpacking psutil>=0.7.1 08:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:06 INFO - Installing collected packages: psutil 08:48:06 INFO - Running setup.py install for psutil 08:48:06 INFO - building 'psutil._psutil_osx' extension 08:48:06 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 08:48:07 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 08:48:07 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 08:48:07 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 08:48:07 INFO - building 'psutil._psutil_posix' extension 08:48:07 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 08:48:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:48:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:48:07 INFO - ^ 08:48:07 INFO - 1 warning generated. 08:48:07 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 08:48:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:07 INFO - Successfully installed psutil 08:48:07 INFO - Cleaning up... 08:48:07 INFO - Return code: 0 08:48:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:07 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 0x102262a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc9358dbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102106d30>, '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 0x101f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020fdb20>, '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.vbJnTeHPQm/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.efxHMadUUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 08:48:07 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 08:48:07 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 08:48:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbJnTeHPQm/Render', 08:48:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:07 INFO - 'HOME': '/Users/cltbld', 08:48:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:07 INFO - 'LOGNAME': 'cltbld', 08:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:07 INFO - 'MOZ_NO_REMOTE': '1', 08:48:07 INFO - 'NO_EM_RESTART': '1', 08:48:07 INFO - 'PAGER': '/bin/cat', 08:48:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:07 INFO - 'PWD': '/builds/slave/test', 08:48:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:07 INFO - 'SHELL': '/bin/bash', 08:48:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.efxHMadUUw/Listeners', 08:48:07 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 08:48:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:07 INFO - 'USER': 'cltbld', 08:48:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:07 INFO - 'XPC_FLAGS': '0x0', 08:48:07 INFO - 'XPC_SERVICE_NAME': '0', 08:48:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:48:07 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 08:48:07 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 08:48:07 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 08:48:07 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 08:48:07 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 08:48:07 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 08:48:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:48:10 INFO - Installing collected packages: mozsystemmonitor 08:48:10 INFO - Running setup.py install for mozsystemmonitor 08:48:10 INFO - Successfully installed mozsystemmonitor 08:48:10 INFO - Cleaning up... 08:48:10 INFO - Return code: 0 08:48:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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')]} 08:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:11 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 0x102262a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc9358dbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102106d30>, '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 0x101f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020fdb20>, '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.vbJnTeHPQm/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.efxHMadUUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 08:48:11 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 08:48:11 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 08:48:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbJnTeHPQm/Render', 08:48:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:11 INFO - 'HOME': '/Users/cltbld', 08:48:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:11 INFO - 'LOGNAME': 'cltbld', 08:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:11 INFO - 'MOZ_NO_REMOTE': '1', 08:48:11 INFO - 'NO_EM_RESTART': '1', 08:48:11 INFO - 'PAGER': '/bin/cat', 08:48:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:11 INFO - 'PWD': '/builds/slave/test', 08:48:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:11 INFO - 'SHELL': '/bin/bash', 08:48:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.efxHMadUUw/Listeners', 08:48:11 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 08:48:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:11 INFO - 'USER': 'cltbld', 08:48:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:11 INFO - 'XPC_FLAGS': '0x0', 08:48:11 INFO - 'XPC_SERVICE_NAME': '0', 08:48:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:11 INFO - Downloading/unpacking blobuploader==1.2.4 08:48:11 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 08:48:11 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 08:48:11 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 08:48:11 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 08:48:11 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 08:48:11 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 08:48:14 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:48:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:15 INFO - Downloading docopt-0.6.1.tar.gz 08:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:48:15 INFO - Installing collected packages: blobuploader, requests, docopt 08:48:15 INFO - Running setup.py install for blobuploader 08:48:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:15 INFO - Running setup.py install for requests 08:48:16 INFO - Running setup.py install for docopt 08:48:16 INFO - Successfully installed blobuploader requests docopt 08:48:16 INFO - Cleaning up... 08:48:16 INFO - Return code: 0 08:48:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48: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')]} 08:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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')]} 08:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:16 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 0x102262a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc9358dbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102106d30>, '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 0x101f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020fdb20>, '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.vbJnTeHPQm/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.efxHMadUUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 08:48:16 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 08:48:16 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 08:48:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbJnTeHPQm/Render', 08:48:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:16 INFO - 'HOME': '/Users/cltbld', 08:48:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:16 INFO - 'LOGNAME': 'cltbld', 08:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:16 INFO - 'MOZ_NO_REMOTE': '1', 08:48:16 INFO - 'NO_EM_RESTART': '1', 08:48:16 INFO - 'PAGER': '/bin/cat', 08:48:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:16 INFO - 'PWD': '/builds/slave/test', 08:48:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:16 INFO - 'SHELL': '/bin/bash', 08:48:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.efxHMadUUw/Listeners', 08:48:16 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 08:48:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:16 INFO - 'USER': 'cltbld', 08:48:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:16 INFO - 'XPC_FLAGS': '0x0', 08:48:16 INFO - 'XPC_SERVICE_NAME': '0', 08:48:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:16 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-E3gpBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:16 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-CTddxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:16 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-twRSmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:16 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-LO3hDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:17 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-D6xele-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:17 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-qMWpvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:17 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-AkHr34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:17 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Vis3XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:17 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-kGTDv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:17 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ZfkpUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:17 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ALAm3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:17 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-35WZm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:17 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Xt27_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:18 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-pI3VRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:18 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ptADvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:18 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-szF4Sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:18 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-wWbnEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:18 INFO - Running setup.py install for manifestparser 08:48:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:18 INFO - Running setup.py install for mozcrash 08:48:18 INFO - Running setup.py install for mozdebug 08:48:18 INFO - Running setup.py install for mozdevice 08:48:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for mozfile 08:48:19 INFO - Running setup.py install for mozhttpd 08:48:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for mozinfo 08:48:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for mozInstall 08:48:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for mozleak 08:48:19 INFO - Running setup.py install for mozlog 08:48:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Running setup.py install for moznetwork 08:48:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Running setup.py install for mozprocess 08:48:20 INFO - Running setup.py install for mozprofile 08:48:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Running setup.py install for mozrunner 08:48:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Running setup.py install for mozscreenshot 08:48:20 INFO - Running setup.py install for moztest 08:48:20 INFO - Running setup.py install for mozversion 08:48:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:20 INFO - Cleaning up... 08:48:20 INFO - Return code: 0 08:48:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48: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')]} 08:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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')]} 08:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:20 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 0x102262a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc9358dbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102106d30>, '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 0x101f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020fdb20>, '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.vbJnTeHPQm/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.efxHMadUUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 08:48:20 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 08:48:20 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 08:48:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbJnTeHPQm/Render', 08:48:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:20 INFO - 'HOME': '/Users/cltbld', 08:48:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:20 INFO - 'LOGNAME': 'cltbld', 08:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:20 INFO - 'MOZ_NO_REMOTE': '1', 08:48:20 INFO - 'NO_EM_RESTART': '1', 08:48:20 INFO - 'PAGER': '/bin/cat', 08:48:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:20 INFO - 'PWD': '/builds/slave/test', 08:48:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:20 INFO - 'SHELL': '/bin/bash', 08:48:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.efxHMadUUw/Listeners', 08:48:20 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 08:48:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:20 INFO - 'USER': 'cltbld', 08:48:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:20 INFO - 'XPC_FLAGS': '0x0', 08:48:20 INFO - 'XPC_SERVICE_NAME': '0', 08:48:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:21 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-7eqL0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:21 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)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:21 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-23pRzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:21 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)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:21 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-hHkOcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:21 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)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:21 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-5wrIAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:21 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)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:21 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-R18Qcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:21 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)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:21 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Uqjvoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:21 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)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:21 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-PWeDi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:21 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)) 08:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:21 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-WKxvXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:22 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-M6cEPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:22 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-YYTLju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:22 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Bs3XOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:22 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-1pBwFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:22 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-tY0nlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:22 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-m62iI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:22 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-w8gRor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:22 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Qg8eUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:22 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)) 08:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:22 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-WpvvTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:23 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)) 08:48:23 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)) 08:48:23 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)) 08:48:23 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)) 08:48:23 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)) 08:48:23 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)) 08:48:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48: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 08:48: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 08:48: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 08:48: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 08:48: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 08:48: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 08:48:25 INFO - Downloading blessings-1.6.tar.gz 08:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:25 INFO - Installing collected packages: blessings 08:48:25 INFO - Running setup.py install for blessings 08:48:25 INFO - Successfully installed blessings 08:48:25 INFO - Cleaning up... 08:48:25 INFO - Return code: 0 08:48:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:26 INFO - Reading from file tmpfile_stdout 08:48:26 INFO - Current package versions: 08:48:26 INFO - blessings == 1.6 08:48:26 INFO - blobuploader == 1.2.4 08:48:26 INFO - docopt == 0.6.1 08:48:26 INFO - manifestparser == 1.1 08:48:26 INFO - mozInstall == 1.12 08:48:26 INFO - mozcrash == 0.17 08:48:26 INFO - mozdebug == 0.1 08:48:26 INFO - mozdevice == 0.48 08:48:26 INFO - mozfile == 1.2 08:48:26 INFO - mozhttpd == 0.7 08:48:26 INFO - mozinfo == 0.9 08:48:26 INFO - mozleak == 0.1 08:48:26 INFO - mozlog == 3.1 08:48:26 INFO - moznetwork == 0.27 08:48:26 INFO - mozprocess == 0.22 08:48:26 INFO - mozprofile == 0.28 08:48:26 INFO - mozrunner == 6.11 08:48:26 INFO - mozscreenshot == 0.1 08:48:26 INFO - mozsystemmonitor == 0.0 08:48:26 INFO - moztest == 0.7 08:48:26 INFO - mozversion == 1.4 08:48:26 INFO - psutil == 3.1.1 08:48:26 INFO - requests == 1.2.3 08:48:26 INFO - wsgiref == 0.1.2 08:48:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:26 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 0x102262a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc9358dbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102106d30>, '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 0x101f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020fdb20>, '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.vbJnTeHPQm/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.efxHMadUUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 08:48:26 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 08:48:26 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 08:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbJnTeHPQm/Render', 08:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:26 INFO - 'HOME': '/Users/cltbld', 08:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:26 INFO - 'LOGNAME': 'cltbld', 08:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:26 INFO - 'MOZ_NO_REMOTE': '1', 08:48:26 INFO - 'NO_EM_RESTART': '1', 08:48:26 INFO - 'PAGER': '/bin/cat', 08:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:26 INFO - 'PWD': '/builds/slave/test', 08:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:26 INFO - 'SHELL': '/bin/bash', 08:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.efxHMadUUw/Listeners', 08:48:26 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 08:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:26 INFO - 'USER': 'cltbld', 08:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:26 INFO - 'XPC_FLAGS': '0x0', 08:48:26 INFO - 'XPC_SERVICE_NAME': '0', 08:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:26 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)) 08:48:26 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)) 08:48:26 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)) 08:48:26 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)) 08:48:26 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)) 08:48:26 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)) 08:48:26 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)) 08:48:26 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)) 08:48:26 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)) 08:48:26 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)) 08:48:26 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)) 08:48:26 INFO - Cleaning up... 08:48:26 INFO - Return code: 0 08:48:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102262a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc9358dbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102106d30>, '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 0x101f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020fdb20>, '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.vbJnTeHPQm/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.efxHMadUUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 08:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbJnTeHPQm/Render', 08:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:26 INFO - 'HOME': '/Users/cltbld', 08:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:26 INFO - 'LOGNAME': 'cltbld', 08:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:26 INFO - 'MOZ_NO_REMOTE': '1', 08:48:26 INFO - 'NO_EM_RESTART': '1', 08:48:26 INFO - 'PAGER': '/bin/cat', 08:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:26 INFO - 'PWD': '/builds/slave/test', 08:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:26 INFO - 'SHELL': '/bin/bash', 08:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.efxHMadUUw/Listeners', 08:48:26 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 08:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:26 INFO - 'USER': 'cltbld', 08:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:26 INFO - 'XPC_FLAGS': '0x0', 08:48:26 INFO - 'XPC_SERVICE_NAME': '0', 08:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:26 INFO - Downloading/unpacking jsonschema 08:48:26 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 08:48:26 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 08:48:26 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 08:48:26 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 08:48:26 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 08:48:26 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 08:48:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:48:28 INFO - Downloading/unpacking functools32 (from jsonschema) 08:48:28 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 08:48:28 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 08:48:28 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 08:48:28 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 08:48:28 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 08:48:28 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 08:48:29 INFO - Downloading functools32-3.2.3-2.tar.gz 08:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:48:29 INFO - warning: no files found matching '*.txt' 08:48:29 INFO - no previously-included directories found matching 'build' 08:48:29 INFO - no previously-included directories found matching 'dist' 08:48:29 INFO - no previously-included directories found matching '.git*' 08:48:29 INFO - Installing collected packages: jsonschema, functools32 08:48:29 INFO - Running setup.py install for functools32 08:48:29 INFO - warning: no files found matching '*.txt' 08:48:29 INFO - no previously-included directories found matching 'build' 08:48:29 INFO - no previously-included directories found matching 'dist' 08:48:29 INFO - no previously-included directories found matching '.git*' 08:48:29 INFO - Successfully installed jsonschema functools32 08:48:29 INFO - Cleaning up... 08:48:29 INFO - Return code: 0 08:48:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102262a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc9358dbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102106d30>, '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 0x101f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020fdb20>, '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.vbJnTeHPQm/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.efxHMadUUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 08:48:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:48:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbJnTeHPQm/Render', 08:48:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:29 INFO - 'HOME': '/Users/cltbld', 08:48:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:29 INFO - 'LOGNAME': 'cltbld', 08:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:29 INFO - 'MOZ_NO_REMOTE': '1', 08:48:29 INFO - 'NO_EM_RESTART': '1', 08:48:29 INFO - 'PAGER': '/bin/cat', 08:48:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:29 INFO - 'PWD': '/builds/slave/test', 08:48:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:29 INFO - 'SHELL': '/bin/bash', 08:48:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.efxHMadUUw/Listeners', 08:48:29 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 08:48:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:29 INFO - 'USER': 'cltbld', 08:48:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:29 INFO - 'XPC_FLAGS': '0x0', 08:48:29 INFO - 'XPC_SERVICE_NAME': '0', 08:48:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:30 INFO - Downloading/unpacking flake8 08:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:48:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:48:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:48:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:48:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:48:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:48:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:48:33 INFO - no previously-included directories found matching 'docs/_build' 08:48:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:48:33 INFO - Running setup.py install for pep8 08:48:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:48:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:48:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:48:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:48:33 INFO - no previously-included directories found matching 'docs/_build' 08:48:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:48:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:48:33 INFO - Cleaning up... 08:48:33 INFO - Return code: 0 08:48:33 INFO - Running post-action listener: _resource_record_post_action 08:48:33 INFO - Running post-action listener: _start_resource_monitoring 08:48:33 INFO - Starting resource monitoring. 08:48:33 INFO - ##### 08:48:33 INFO - ##### Running install step. 08:48:33 INFO - ##### 08:48:33 INFO - Running pre-action listener: _resource_record_pre_action 08:48:33 INFO - Running main action method: install 08:48:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:34 INFO - Reading from file tmpfile_stdout 08:48:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:34 INFO - Reading from file tmpfile_stdout 08:48:34 INFO - Output received: 08:48:34 INFO - Usage: mozinstall [options] installer 08:48:34 INFO - Options: 08:48:34 INFO - -h, --help show this help message and exit 08:48:34 INFO - -d DEST, --destination=DEST 08:48:34 INFO - Directory to install application into. [default: 08:48:34 INFO - "/builds/slave/test"] 08:48:34 INFO - --app=APP Application being installed. [default: firefox] 08:48:34 INFO - mkdir: /builds/slave/test/build/application 08:48:34 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'] 08:48:34 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 08:49:08 INFO - Reading from file tmpfile_stdout 08:49:08 INFO - Output received: 08:49:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:49:08 INFO - Running post-action listener: _resource_record_post_action 08:49:08 INFO - ##### 08:49:08 INFO - ##### Running run-tests step. 08:49:08 INFO - ##### 08:49:08 INFO - Running pre-action listener: _resource_record_pre_action 08:49:08 INFO - Running main action method: run_tests 08:49:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:49:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:49:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:49:08 INFO - 2016-03-16 08:49:08.245 screenresolution[1644:7682] starting screenresolution argv=screenresolution get 08:49:08 INFO - 2016-03-16 08:49:08.248 screenresolution[1644:7682] Display 0: 1600x1200x32@60 08:49:08 INFO - 2016-03-16 08:49:08.252 screenresolution[1645:7684] starting screenresolution argv=screenresolution list 08:49:08 INFO - Available Modes on Display 0 08:49:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:49:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:49:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:49:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:49:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:49:08 INFO - Intel Iris: 08:49:08 INFO - Chipset Model: Intel Iris 08:49:08 INFO - Type: GPU 08:49:08 INFO - Bus: Built-In 08:49:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:49:08 INFO - Vendor: Intel (0x8086) 08:49:08 INFO - Device ID: 0x0a2e 08:49:08 INFO - Revision ID: 0x0009 08:49:08 INFO - Displays: 08:49:08 INFO - Display: 08:49:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:49:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:49:08 INFO - Display Serial Number: 1600x1200 60 08:49:08 INFO - Main Display: Yes 08:49:08 INFO - Mirror: Off 08:49:08 INFO - Online: Yes 08:49:08 INFO - Rotation: Supported 08:49:08 INFO - Return code: 0 08:49:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:49:08 INFO - Python 2.7.3 08:49:08 INFO - Return code: 0 08:49:08 INFO - grabbing minidump binary from tooltool 08:49:08 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')]} 08:49:08 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 0x102106d30>, '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 0x101f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020fdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:49:08 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 08:49:08 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 08:49:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:49:08 INFO - Return code: 0 08:49:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:49:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:49:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:49:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:49:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:49:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:49:09 INFO - Return code: 0 08:49:09 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/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--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 08:49:09 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/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0143 --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 08:49:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vbJnTeHPQm/Render', 08:49:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:09 INFO - 'HOME': '/Users/cltbld', 08:49:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:09 INFO - 'LOGNAME': 'cltbld', 08:49:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:49:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:09 INFO - 'MOZ_NO_REMOTE': '1', 08:49:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:49:09 INFO - 'NO_EM_RESTART': '1', 08:49:09 INFO - 'PAGER': '/bin/cat', 08:49:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:09 INFO - 'PWD': '/builds/slave/test', 08:49:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:49:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:09 INFO - 'SHELL': '/bin/bash', 08:49:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.efxHMadUUw/Listeners', 08:49:09 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 08:49:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:09 INFO - 'USER': 'cltbld', 08:49:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:09 INFO - 'XPC_FLAGS': '0x0', 08:49:09 INFO - 'XPC_SERVICE_NAME': '0', 08:49:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:09 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/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--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 08:49:09 INFO - mozversion application_buildid: 20160316064345 08:49:09 INFO - mozversion application_changeset: 360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b 08:49:09 INFO - mozversion application_display_name: Nightly 08:49:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:49:09 INFO - mozversion application_name: Firefox 08:49:09 INFO - mozversion application_remotingname: firefox 08:49:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:49:09 INFO - mozversion application_vendor: Mozilla 08:49:09 INFO - mozversion application_version: 48.0a1 08:49:09 INFO - mozversion platform_buildid: 20160316064345 08:49:09 INFO - mozversion platform_changeset: 360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b 08:49:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:49:09 INFO - mozversion platform_version: 48.0a1 08:49:09 INFO - using testdate: 1458143349 08:49:09 INFO - actual date: 1458143349 08:49:09 INFO - starting webserver on 'localhost:49270' 08:49:09 INFO - SUITE-START | Running 2 tests 08:49:09 INFO - TEST-START | dromaeo_css 08:49:09 INFO - operating with platform_type : mac_ 08:49:09 INFO - Initialising browser for dromaeo_css test... 08:49:10 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpxbki0u/profile http://localhost:49270/getInfo.html) 08:49:12 INFO - PROCESS | 1663 | 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] 08:49:13 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 08:49:13 INFO - PROCESS | 1663 | colorDepth:24 08:49:13 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 08:49:13 INFO - PROCESS | 1663 | __metrics 08:49:13 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 08:49:14 INFO - TEST-INFO | 1663: exit 0 08:49:14 INFO - Browser initialized. 08:49:14 INFO - Running cycle 1/1 for dromaeo_css test... 08:49:14 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpxbki0u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:25 INFO - PROCESS | 1667 | RSS: Main: 255062016 08:49:25 INFO - PROCESS | 1667 | 08:50:15 INFO - PROCESS | 1667 | 1458143415576 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] 08:52:26 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 08:52:27 INFO - PROCESS | 1667 | RSS: Main: 269996032 08:52:27 INFO - PROCESS | 1667 | 08:55:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 08:55:29 INFO - PROCESS | 1667 | RSS: Main: 281403392 08:55:29 INFO - PROCESS | 1667 | 08:58:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 08:58:32 INFO - PROCESS | 1667 | RSS: Main: 282763264 08:58:32 INFO - PROCESS | 1667 | 09:01:34 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 09:01:34 INFO - PROCESS | 1667 | RSS: Main: 284819456 09:01:34 INFO - PROCESS | 1667 | 09:04:37 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 09:04:37 INFO - PROCESS | 1667 | RSS: Main: 286834688 09:04:37 INFO - PROCESS | 1667 | 09:07:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 09:07:40 INFO - PROCESS | 1667 | RSS: Main: 288948224 09:07:40 INFO - PROCESS | 1667 | 09:07:40 INFO - PROCESS | 1667 | __start_tp_report 09:07:40 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 09:07:40 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 09:07:40 INFO - PROCESS | 1667 | |i|pagename|runs| 09:07:40 INFO - PROCESS | 1667 | |0;dojo.html;3534.982325088374;3535.010197144799;3571.9642803571974;3591.8024508652047;3636.1273294409334;5902.616329938551;5915.378885217055;5918.940810591893;5924.637969149753;5942.168096466493;5786.479216870481;5895.6462612243295;5954.464098231169;5964;6060.999935010718;5313.495217954288;5371.435999220084;5372.758225879845;5392.811251606195;5483.451654834505;150.55965667801033;5365.3293338332705;5398.163284690879;5402.8919421611545;5458.781648734046;5354.437784032679;5357.866053348658;5367.704776237305;5381.730913454312;5394.7842086316505;5295.761690723926;5381.838544843661;5426.240326354314;5442.564594832404;5453.836384908459;5271.28837606922;5300.363956325227;5336.119540275849;5373.247745315659;5420.051490989061;4527.728336299832;5774.2782152230975;5790.10253410722;5812.157237200582;5876.6180198286975;6152.538559608047;6176.81469555914;6294.968525157345;6303.653299068549;6304.211973503312;6236.688165591702;6288.591241569329;6308.2745484269435;6309.148264984215;6317.241930968313;5997.310309314441;6020.879582408327;6024.48791852693;6046.667433291123;6055.7593690334415;5075.441701412841;5370.973145134328;5700.778367899927;6450.161479007793;6450.935490645127;5149.871253218699;6258.718357673915;6286.18279623646;6298.685065746694;6301.684915754194;5182.714950677673;6248.28144763349;6267.6866156691985;6317.399847014526;6333.714982825784;5187.455317191716;6147.985582378947;6201.503879689614;6289.654069026156;6308.116863639094;5243.5542978847225;6112.07796728157;6220.098085777628;6267.874642507124;6288.371162883675;4966.553010229024;5000.39995200571;5048.697078175322;5052.6715763475995;5097.209932460474;4438.289873620205;4479.731216126977;4535.931961020588;4545.931811022837;4572.314152877095;5009.899802004013;6018.21763170785;6029.788957386558;6073;6092.39076092396;6310.337414571404;6366;6371.553991220663;6372.107904893319;6387.712552935129;4968.552830245295;5929.110633405024;5994.850128746816;6079.452849243589;6130.846728831726;5473.808416705396;5476.698781567052;5493.368262649767;5520.089185284383;5533.253010843565;6356.4279214870885;6568.704408301638;6575.736970521126;6576.539642225094;6580.967095164589;6245.718942647501;6299.401556852092;6314.368563143833;6314.684265786784;6329.1139240505445;6324.367563243639;6359.586626869239;6380.106785050004;6387.425131738166;6388.93611063902;6105.206323178136;6117.174181485442;6150.200473938359;6174.44430001302;6231.906521402092;6171.290301615371;6266.811995640138;6351;6356.396142366468;6361.4274715274;6198.659073750987;6221.813345599639;6241.469475094668;6244.406781355764;6244.68776561161;6106.673025714385;6187.102870083902;6216.191895053614;6216.813495595139;6232.532560057924;5340.626156169031;5367;5781.682007489629;5956.553258505716;6136.641621527207;6214.5028397727165;6235.812925612239;6288.874222515433;6291.307956124914;6298.622082675054;6055.909161362495;6081.331053584191;6129.049997250433;6167.013277875519;6210 09:07:40 INFO - PROCESS | 1667 | |1;ext.html;428.47083851443483;597.4891467795035;601.9578629495937;636.7866764633848;651.605778504005;37477.81261093694;37894.052648683726;38082.8095859521;38095;38220.426693599584;33396.499052514235;39274.41088383677;39316.01709957253;39558;39953.00117497064;7560.886586701204;9409.623615055407;9621.95189024054;9636.518174091267;9869.70390888271;9502.907165675966;9731.36746111504;9764.804703905918;9823.95088024559;9835.262355323344;8461.815345851586;9613.942466328699;9801.656942007032;9850.901490985107;9858.605655773796;9707.271954603433;9756.4633945133;9832.26258030647;9837.606495740161;9851.211903047739;9595.472249026301;9678.806423871483;9693.70918872435;9717.805643887154;9764.90235097647;32201;37993.62006379929;38460.42309365362;38770.41844372336;38804.22391552181;3103.2707313781243;3203.743700503954;3207.7914935529116;3384.7461440392067;3491.9650803491895;23169.652455213185;27476.862615686994;27793.86103069492;28467;28804.8559757202;2679.879405426741;2711.0646826844904;2713.782897368206;2717.184844546648;2867.971320286791;398954;412791;420082;420910.58178836555;423587.9999999969;45025.77487112543;59838;60006;60022.099668505005;60023.69988150031;44691.553084469386;44706.43527476523;45006.09987800226;45062.77468612701;45146.32280515795;15442.768358474632;15652.139132347831;15930.92034539843;15941.202939852961;16021.839781602268;12248.693782655326;12661.240325580495;12706.237625742486;12789.168704034208;12845.550405735941;11954.581589644495;12012.819807702892;14362.353694083582;14672.706545869236;14824;5478.45215478449;6573.474122070223;6646.26891041985;6684.131062961784;6685.829979753524;930.283681565191;949.9525023748923;952.5999080386255;978.9461579613189;1031.865857438528;23258.65112023321;29161.854190729337;29316.267093322836;29840;30166.547501787492;921.6083164654995;1098.6374496416324;1119.2221406122667;1171.666075168573;1188.1623455463878;15218;16391.91804040996;16569.751453728204;16579;16824.91587542079;631249;635387;640510;640574;642061;61085.77828443406;61124.777504450554;61530.0770488443;61560.38439615636;61603.69198153981;1403.6140061483175;1468.3319089814108;1471.1540864003027;1479.6300924768807;1480.8445113263167;29925.700742992292;30269.394612107193;30352.54471182978;30439.54340684936;30759.846200768854;50797.49202507928;51198.232026520374;51759.22361164661;51817.7409112952;51865.481345187574;500791;513493;517029;518979;519206;31952.36095278128;32712.855050073133;32751.508727368633;33066.66933330732;33132;43341.69974900758;43446.524278058314;44105.77947110244;45308.32037519506;45379.54620453753;29566.408671826874;34331.65668343285;34911.65088349186;36078;36950;28615.42769144647;30555.2361190972;34719.82640086884;36466;38014.429783553824;35813.64186358103;35874.820625896704;36645.63354366422;36698.8165059173;36745.816270919546;26581.069662561717;28807.855960720062;29591.852040739657;31895;32213.838930805196;24008.039678412668;24138.275851724477;24494.63258051166;24594.50810983806;24601.384965376008 09:07:40 INFO - PROCESS | 1667 | |2;jquery.html;356.5436241610739;360.644764906567;366.6132230496826;369.74487603553564;370.9035650730811;19061.23755049798;19455;20038.29865954692;20259.59480810383;20315.593688126228;20001.199952001938;20391.796082039175;20548;20562.383128506168;20578.588428231466;5695.971520142404;5985;5985.16207730918;6015.458608725214;6018.247719035121;4244.405783190356;5870.794522191724;6257.968710156443;6526.412622863942;6565.277819439858;6432.485401167895;6467.256265529454;6472.255690595594;6486.805395838132;6489.772857949973;5012.423571289312;5401.837944861661;5676.631018983794;5682.346530149044;5709.685967271798;5323.946760532383;5346.117890548055;5423.430539793304;5427.565794736412;5447.618666693333;12652.493900243979;13108.934455327662;13121.540746073937;13252.337383130805;13360.799588006188;1998.1907327532372;2090.6550419180817;2129.4782778219437;2244.696965909614;2664.5603475426533;9947.303688741718;10749.647801434692;11503.849615038513;14153.575392738234;14574.927125364306;1409.9083559568596;1588.2217713320506;1695.6862980348676;1700.5493544210794;1720.6558688262398;63251.68374158146;75441.49117017629;80718.98202544983;96165;98120;11014.39420831862;11167.944160279147;11281.887181128248;11307.265027773168;11444.94277528607;13433.26117063571;13518;13518.324083795771;13535.187888726708;13603.863961360457;8344.874826877602;8518.190771876662;8555.871661925075;8593.742187734253;8619.310455163697;8588.22705956467;8627.95686021566;8643.654253829776;8648.870266946002;8722;3564.4475106358555;4371.672124590668;4457.866264012085;4518.819247230074;4558.111168322212;1739.2608141539795;1822.4623735997911;1843.6404901044436;1844.9446516604523;1868.747719057937;909.7498187998222;943.1464524605243;948.3314263444255;963.5037955452947;963.7542426681291;13611;18677.533061673294;19013.42959711211;19110.33113841009;19210.903945480182;842.0905422144069;996.7458298133929;997.2769741937183;1020.3112898793285;1022.5143057047992;10559;10751.354918704903;10765.569377224823;10799.136069114453;10877.401742904058;592909;596506.0174699186;597704;604741;614514;78571.21428785754;99349.01301974064;105763;106525;107625;1029.0429900192892;1033.1528146919604;1034.0796690945215;1039.3296323871211;1039.6932904793105;17179;17370.131493425026;17567.560810979827;17760.200790964696;17966.101694915462;46812;47395.76302118467;47429;47703.28445073257;49210.27764028242;63814.68092659693;64968.35031649812;67055.99416008861;67451.3254867445;69479;7218.133823941161;7282.635868206463;7350.852982940204;7523.134839493309;7627.656755445907;10934.56261749521;11062.944685276521;11706;11804.76390472203;12076.456559455022;10088.899111008795;10142.985701429798;10289.691309260734;10328.896711032794;10350.844737329096;8439.704610338855;8753.255973242345;9538.85691714611;9889.752756180866;10288.897111029093;10278.430392401899;10437.373757574569;10527.052565269163;10559;10643.787124257626;7172.892406614009;7274.054372931697;7382.187959324578;7523.623818809147;7615.086189657277;9993.600255989679;10283.07452329294;10358.844617330897;10570.630027948984;10579.576816927236 09:07:40 INFO - PROCESS | 1667 | |3;mootools.html;1385.4527461652647;1604.2620394618475;1866.2814816295731;2002.6995950607406;2018.788027257137;7312.561246325225;7899.684012639487;8530.829383412329;8701.08638592948;8931.285497160228;7102.928970710304;8638.179372959574;8658.090900455456;8754.912450875489;8786.209241168293;2453.264020793764;2476.1333533263305;2481.0323973650293;2485.763852434016;2490.8380955237944;2425.8908349124245;2483.205374280231;2487.577111890983;2490.0537795637633;2509.3099397665605;2084.81236688698;2472.221250306157;2482.5283196192754;2487.440325926661;2527.4818662174303;2440.048381131369;2442.474867903409;2482.714487833904;2488.776010159085;2514.019532382354;2445.4986727720775;2468.8148388870904;2509.0841842727455;2512.459821138464;2516.169664010872;6388;8813.206811387006;8837.690680826141;8848.115188481164;8862.42394244372;4654.4647365553055;5420.783168673248;5517.089680202762;5545.889082218373;5550.639208451437;3586;3627.220147668264;3688.5573731152435;3762.3792074307707;3773.792441415721;1039.4335087377397;1058.925875188737;1061.1669839176286;1062.8671416072991;1067.5783065689009;11636.360000199986;11802.704932376759;11819.34993575353;11843.940780296129;11844.34856082915;4094.7747873867224;4918.532739389752;4952.727599981963;4955.231939049381;5042.773075211624;10090.142337901361;10145.442000690033;10191.643292484727;10199.337043092175;10202.795944081077;5487.42382049887;5556.222128901957;5562.888742225133;5589.5807814413265;5591.916121258185;3691.8154092295276;3961.7622942623534;4997.550220480174;5027.698338099725;5051.4695956924725;2556.4120252342063;2711.0209547030386;3942.172143849766;3982.5818289079807;4029.959700403017;1318.156379916854;1329.9135556188817;1337.0172922901659;1340.517413731056;1342.2617560341773;1125.8254970479588;1128.058071510298;1138.5445821671399;1321.5837011341396;1427.3862239237021;8160.714374996846;8254.215849494289;8292.212239837207;8357.665693372319;8385.371097167616;510.81865937592363;516.767454645411;516.8371962831771;519.6855902179203;522.2114606943543;6088.543359248074;6100.3899610039525;6159.876802463926;6218.782342617987;6221.595596286227;10125.291229613857;10323.277370584137;10378.948105259426;10394;10445.11216546602;8399.328053755686;10071.748206294902;10242.53908574116;10266.435346055889;10369.792604147875;8227.465214761021;8407.117252688502;8426.578671066422;8479.533625650649;8488.915110848937;8080.232377924088;8084.868118463537;8092.757217283491;8142.796430089058;8359.247667709935;9378.624855005723;9458.385204961656;9691.5154242289;9761.755956101155;9788.510574471391;8068.7579372616565;9695.369800962915;9812.264080194156;9977.50112494358;9991;6663.13379260693;7430.182679905314;7566.394688425023;7705.113911899979;7736.8452630948195;8223.794405139919;8280.58597070156;8320.542370169698;8371.95814020926;8380.078191399063;7304.086989126359;7379.446541509516;7381.44639152055;7568;7620.542767433972;5844.649321040752;6762.917933130676;6827.873400888798;7245.2030276670575;7363.926360736324;6326.715297811702;6833.282505336868;7613.467057305936;7765.22347765219;7782.49413788102;6249.718762655601;6488.416042556192;6939.861202776017;6964.1643002837955;7008.894866576903;5861.9413805861395;7063.6821343038655;7102.289771022856;7135.143782746104;7147.392471639969 09:07:40 INFO - PROCESS | 1667 | |4;prototype.html;319.87684741374574;324.9447593909035;325.8924554896884;326.1227298566856;327.6068717538953;5407.648502847322;6781;6828.951314605617;6880.8967865482055;6933.168019837614;6743.561668491545;6773.864522709543;6781.76263830766;6781.796546103613;6810;4737.928931066037;4869.659123861331;4987.177115775893;5010.198368261079;5021.673591216569;4958.652894297401;4958.925616115761;4969.577585905203;4980.601551875841;4985.975070124662;4894.8286809961655;4904.803807847682;4923.9753801230945;4924.842661974433;4950.059488697136;4904.06822703687;4923.82766603169;4933.235348520967;4954.752262386866;4977.701337919701;4236.6187043165955;4253.171136411342;4260.9147817043795;4266.168097221043;4271.786410679453;5260.105782017028;6342.746290148435;6540.607563546202;6595.8021259362295;6612.471002319803;5827.970860145672;5863.9738045841805;5874.970625146847;5892.499137573312;5911.083782013795;7199.6040217788;7209.639518024078;7225.241349658263;7241.927580724178;7249.16634587024;4687.88280292992;4720.504347043579;4725.9527404726205;4731.550502702238;4744.976275118637;7700.768976930645;7702.8844567331535;7712.228777122299;7719.34385577221;7720.07359116904;3917.3928041153667;4320.200762858881;4670.789814458358;4691.835785747482;4785.784639691222;4855.271709243641;4855.4173499179615;4857.684250523705;4861.538153875376;4862.878428039327;5722.942770572325;5782.161586569924;5788.0739081746715;5813.633796057923;5871.089981052944;7279.526830755984;7292.45306602007;7298.379637730746;7302.56184628924;7336.486445948839;1598.5683865356289;1651.265186991801;1655.1641421082277;1682.3354774864106;1707.7523759054868;919.2324409118328;986.3588667366126;1088.4435257581733;1099.14816017587;1110.9777804443866;6735.663216839139;6759.628220447824;6804.217514985741;6815.897761533581;6816.386525212754;6587.538872278895;7001.824954376181;7489.475736698379;7522.398208143445;7528.473006889575;6724.462043036546;6726.7981960541265;6742.932570674328;6743;6769.559978601375;3636.4181730922924;3960.5445373782386;3991.660708839723;4001.8199181036925;4002.459667944848;6427.22873255203;7756.224377562198;7780.766577002699;7829.177936316605;8055.073666528424;6284.685765711696;7859.567723775247;7878.566678832604;7889.526628402315;7912.525248485109;8008.239217274349;8023.719169828912;8028.759137225892;8036.919630803617;8040.638171282307;7305.926940730525;7585.165631780389;7586.962065189638;7615.809604759926;7631.519756079408;7435.553866768011;7471.402287816853;7477.102747670315;7481.513701609378;7509.962450187714;7986.440949133737;7996.680132794856;8000.079990800899;8000.759977200693;8011.599420029092;3969.146633473817;4058.675305975574;4734.692245004064;4823.3729615149805;4836.854894353175;6445.871082578228;7155.42756579462;7255.600941948243;7541.6229188539255;7561.319481246494;6489;6645;7207.639618019183;7241.601711905896;7253.093363329584;7273.781786546412;7294.927050729425;7316.524425912298;7318.121825380988;7347.742829001173;7104.431645468247;7112.075430194249;7112.537685050455;7118.466115041289;7141.678624462015;7076.646167691698;7279.381252593589;7306.4885458017425;7338.816529586803;7348.70605175787;5654.547636189177;7122;7136.678849451683;7150.821229469305;7171.247019062923 09:07:40 INFO - PROCESS | 1667 | |5;yui.html;697.0728930522406;699.6431819771918;745.6830846890072;770.9845803083939;796.311190819941;17641;17863.82136178641;17997.820021799776;18024.54938626535;18082;16414.589635259093;16449.91775041126;16488.01071935682;16497.422590209346;16521.91739041303;731.297953964195;874.8600223964168;931.8415869302218;946.5361972633394;948.7011591348737;934.6168071090854;936.148105224246;941.4821847983616;947.0955237747969;949.4208532794989;996.3374356053216;998.8002399520088;1000.8398656215007;1001.944893030883;1005.0753306957616;980.9362391444569;988.8220120378329;991.8165139449225;999.3154689038032;999.7200783780553;727.0221552012534;732.4250463386217;734.111724812977;737.2185483387626;740.0305599664457;15658.451954181663;15724.606884827856;15762.290696918666;15788.447404340908;15802.683946321124;12533.874661253452;12569.811452828124;12722.554710585086;12728.80906786399;12826.230426174367;10082.798344033079;10082.798344033079;10101.292909496338;10151.898481015169;10856.891431085667;3497.265574229415;3536.6286539913453;3537.964620353789;3582.5342705448384;3674.8713795017047;57854.710726446516;78522.60738696327;79380.41239175184;80356.19643803604;81007;7492.250774922573;7774.494657847222;9184.724458266262;9307.674231401868;9331.90668093324;21145.894270528857;21265.36203913885;21315;21348;21402.143914243567;6715.664216789141;7041.5775053496955;7299.489035767551;7317.12194536659;7321.450891183183;3924.7056470764805;3927.626875446828;3979.621935916083;3984.6452206250015;3995.10110225197;3572.7677700949357;3584.390653588896;3594.6944509716445;3602.6757591816863;3604.621514740967;529.6027979015738;644.432899048834;646.0954663471178;651.501601275025;658.1674182159572;509.6228790694859;567.3560508822516;592.8843875444247;595.8182754259992;624.1449214575969;8028.83942321162;8158;8196.42625016243;8246.876296855551;8354.540500272422;526.3420724094882;567.0332083797116;585.3736501942881;600.2916558461058;623.0342968398963;3620.475031120473;3683.4106542953;3727.683146932541;3869.9613003870163;3890.7860067696547;71650.64174679093;95188.52405737927;96675.033249668;96828.51585742168;97082;81019;81549.59225203954;82279;82546;84462.57768711117;70878.64560677164;71300.28699712937;71466.64266678633;72438.63780681063;73121.90317145248;8315.085340612648;8320.209580089882;8359.080501144748;8378.53918034514;8431.241188293083;50484;51172.46482605528;51235.975280494924;51493.71265718237;51921;61362.38637613567;62965.79619713288;66599;70134.24664383431;71135.28864711494;11000.339979601249;11019.953104455064;11055.28140670886;11211.55153793839;11259.211855170059;11799.705007374885;11962.58130965412;12089.637310880336;12308.384580771104;12852.871471285167;11256.437178141225;11285.322880627189;11461.770764584495;11823.52705891789;11904.226225295328;11344.432778361213;11372.147088968526;11479.196456247982;11757.294562326288;12375.938120309702;9752.756181095245;11177.329360238411;11373.374464404536;11745.647630571097;12427.627171184879;9596.712098637052;9752.073553012453;9784.951075244579;9950.054744799232;10080.495975201064;9337.112974267433;9619;9641.807163856824;9661.855072173783;9735.318527703275 09:07:40 INFO - PROCESS | 1667 | __end_tp_report 09:07:40 INFO - PROCESS | 1667 | __start_cc_report 09:07:40 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,365 09:07:40 INFO - PROCESS | 1667 | __end_cc_report 09:07:40 INFO - PROCESS | 1667 | __startTimestamp1458144460666__endTimestamp 09:07:40 INFO - PROCESS | 1667 | 09:07:40 INFO - PROCESS | 1667 | ------- Summary: start ------- 09:07:40 INFO - PROCESS | 1667 | Number of tests: 6 09:07:40 INFO - PROCESS | 1667 | 09:07:40 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5777.59 Median:6061.00 stddev:773.85 (12.8%) stddev-sans-first:755.96 09:07:40 INFO - PROCESS | 1667 | Values: 3535.0 3535.0 3572.0 3591.8 3636.1 5902.6 5915.4 5918.9 5924.6 5942.2 5786.5 5895.6 5954.5 5964.0 6061.0 5313.5 5371.4 5372.8 5392.8 5483.5 150.6 5365.3 5398.2 5402.9 5458.8 5354.4 5357.9 5367.7 5381.7 5394.8 5295.8 5381.8 5426.2 5442.6 5453.8 5271.3 5300.4 5336.1 5373.2 5420.1 4527.7 5774.3 5790.1 5812.2 5876.6 6152.5 6176.8 6295.0 6303.7 6304.2 6236.7 6288.6 6308.3 6309.1 6317.2 5997.3 6020.9 6024.5 6046.7 6055.8 5075.4 5371.0 5700.8 6450.2 6450.9 5149.9 6258.7 6286.2 6298.7 6301.7 5182.7 6248.3 6267.7 6317.4 6333.7 5187.5 6148.0 6201.5 6289.7 6308.1 5243.6 6112.1 6220.1 6267.9 6288.4 4966.6 5000.4 5048.7 5052.7 5097.2 4438.3 4479.7 4535.9 4545.9 4572.3 5009.9 6018.2 6029.8 6073.0 6092.4 6310.3 6366.0 6371.6 6372.1 6387.7 4968.6 5929.1 5994.9 6079.5 6130.8 5473.8 5476.7 5493.4 5520.1 5533.3 6356.4 6568.7 6575.7 6576.5 6581.0 6245.7 6299.4 6314.4 6314.7 6329.1 6324.4 6359.6 6380.1 6387.4 6388.9 6105.2 6117.2 6150.2 6174.4 6231.9 6171.3 6266.8 6351.0 6356.4 6361.4 6198.7 6221.8 6241.5 6244.4 6244.7 6106.7 6187.1 6216.2 6216.8 6232.5 5340.6 5367.0 5781.7 5956.6 6136.6 6214.5 6235.8 6288.9 6291.3 6298.6 6055.9 6081.3 6129.0 6167.0 6210.0 09:07:40 INFO - PROCESS | 1667 | 09:07:40 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:64991.27 Median:38088.90 stddev:141783.87 (372.2%) stddev-sans-first:142098.75 09:07:40 INFO - PROCESS | 1667 | Values: 428.5 597.5 602.0 636.8 651.6 37477.8 37894.1 38082.8 38095.0 38220.4 33396.5 39274.4 39316.0 39558.0 39953.0 7560.9 9409.6 9622.0 9636.5 9869.7 9502.9 9731.4 9764.8 9824.0 9835.3 8461.8 9613.9 9801.7 9850.9 9858.6 9707.3 9756.5 9832.3 9837.6 9851.2 9595.5 9678.8 9693.7 9717.8 9764.9 32201.0 37993.6 38460.4 38770.4 38804.2 3103.3 3203.7 3207.8 3384.7 3492.0 23169.7 27476.9 27793.9 28467.0 28804.9 2679.9 2711.1 2713.8 2717.2 2868.0 398954.0 412791.0 420082.0 420910.6 423588.0 45025.8 59838.0 60006.0 60022.1 60023.7 44691.6 44706.4 45006.1 45062.8 45146.3 15442.8 15652.1 15930.9 15941.2 16021.8 12248.7 12661.2 12706.2 12789.2 12845.6 11954.6 12012.8 14362.4 14672.7 14824.0 5478.5 6573.5 6646.3 6684.1 6685.8 930.3 950.0 952.6 978.9 1031.9 23258.7 29161.9 29316.3 29840.0 30166.5 921.6 1098.6 1119.2 1171.7 1188.2 15218.0 16391.9 16569.8 16579.0 16824.9 631249.0 635387.0 640510.0 640574.0 642061.0 61085.8 61124.8 61530.1 61560.4 61603.7 1403.6 1468.3 1471.2 1479.6 1480.8 29925.7 30269.4 30352.5 30439.5 30759.8 50797.5 51198.2 51759.2 51817.7 51865.5 500791.0 513493.0 517029.0 518979.0 519206.0 31952.4 32712.9 32751.5 33066.7 33132.0 43341.7 43446.5 44105.8 45308.3 45379.5 29566.4 34331.7 34911.7 36078.0 36950.0 28615.4 30555.2 34719.8 36466.0 38014.4 35813.6 35874.8 36645.6 36698.8 36745.8 26581.1 28807.9 29591.9 31895.0 32213.8 24008.0 24138.3 24494.6 24594.5 24601.4 09:07:40 INFO - PROCESS | 1667 | 09:07:40 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:32244.84 Median:1962.55 stddev:99034.02 (5046.2%) stddev-sans-first:99282.89 09:07:40 INFO - PROCESS | 1667 | Values: 356.5 360.6 366.6 369.7 370.9 19061.2 19455.0 20038.3 20259.6 20315.6 20001.2 20391.8 20548.0 20562.4 20578.6 5696.0 5985.0 5985.2 6015.5 6018.2 4244.4 5870.8 6258.0 6526.4 6565.3 6432.5 6467.3 6472.3 6486.8 6489.8 5012.4 5401.8 5676.6 5682.3 5709.7 5323.9 5346.1 5423.4 5427.6 5447.6 12652.5 13108.9 13121.5 13252.3 13360.8 1998.2 2090.7 2129.5 2244.7 2664.6 9947.3 10749.6 11503.8 14153.6 14574.9 1409.9 1588.2 1695.7 1700.5 1720.7 63251.7 75441.5 80719.0 96165.0 98120.0 11014.4 11167.9 11281.9 11307.3 11444.9 13433.3 13518.0 13518.3 13535.2 13603.9 8344.9 8518.2 8555.9 8593.7 8619.3 8588.2 8628.0 8643.7 8648.9 8722.0 3564.4 4371.7 4457.9 4518.8 4558.1 1739.3 1822.5 1843.6 1844.9 1868.7 909.7 943.1 948.3 963.5 963.8 13611.0 18677.5 19013.4 19110.3 19210.9 842.1 996.7 997.3 1020.3 1022.5 10559.0 10751.4 10765.6 10799.1 10877.4 592909.0 596506.0 597704.0 604741.0 614514.0 78571.2 99349.0 105763.0 106525.0 107625.0 1029.0 1033.2 1034.1 1039.3 1039.7 17179.0 17370.1 17567.6 17760.2 17966.1 46812.0 47395.8 47429.0 47703.3 49210.3 63814.7 64968.4 67056.0 67451.3 69479.0 7218.1 7282.6 7350.9 7523.1 7627.7 10934.6 11062.9 11706.0 11804.8 12076.5 10088.9 10143.0 10289.7 10328.9 10350.8 8439.7 8753.3 9538.9 9889.8 10288.9 10278.4 10437.4 10527.1 10559.0 10643.8 7172.9 7274.1 7382.2 7523.6 7615.1 9993.6 10283.1 10358.8 10570.6 10579.6 09:07:40 INFO - PROCESS | 1667 | 09:07:40 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5937.90 Median:5454.10 stddev:3151.44 (57.8%) stddev-sans-first:3141.70 09:07:40 INFO - PROCESS | 1667 | Values: 1385.5 1604.3 1866.3 2002.7 2018.8 7312.6 7899.7 8530.8 8701.1 8931.3 7102.9 8638.2 8658.1 8754.9 8786.2 2453.3 2476.1 2481.0 2485.8 2490.8 2425.9 2483.2 2487.6 2490.1 2509.3 2084.8 2472.2 2482.5 2487.4 2527.5 2440.0 2442.5 2482.7 2488.8 2514.0 2445.5 2468.8 2509.1 2512.5 2516.2 6388.0 8813.2 8837.7 8848.1 8862.4 4654.5 5420.8 5517.1 5545.9 5550.6 3586.0 3627.2 3688.6 3762.4 3773.8 1039.4 1058.9 1061.2 1062.9 1067.6 11636.4 11802.7 11819.3 11843.9 11844.3 4094.8 4918.5 4952.7 4955.2 5042.8 10090.1 10145.4 10191.6 10199.3 10202.8 5487.4 5556.2 5562.9 5589.6 5591.9 3691.8 3961.8 4997.6 5027.7 5051.5 2556.4 2711.0 3942.2 3982.6 4030.0 1318.2 1329.9 1337.0 1340.5 1342.3 1125.8 1128.1 1138.5 1321.6 1427.4 8160.7 8254.2 8292.2 8357.7 8385.4 510.8 516.8 516.8 519.7 522.2 6088.5 6100.4 6159.9 6218.8 6221.6 10125.3 10323.3 10378.9 10394.0 10445.1 8399.3 10071.7 10242.5 10266.4 10369.8 8227.5 8407.1 8426.6 8479.5 8488.9 8080.2 8084.9 8092.8 8142.8 8359.2 9378.6 9458.4 9691.5 9761.8 9788.5 8068.8 9695.4 9812.3 9977.5 9991.0 6663.1 7430.2 7566.4 7705.1 7736.8 8223.8 8280.6 8320.5 8372.0 8380.1 7304.1 7379.4 7381.4 7568.0 7620.5 5844.6 6762.9 6827.9 7245.2 7363.9 6326.7 6833.3 7613.5 7765.2 7782.5 6249.7 6488.4 6939.9 6964.2 7008.9 5861.9 7063.7 7102.3 7135.1 7147.4 09:07:40 INFO - PROCESS | 1667 | 09:07:40 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5907.23 Median:6743.28 stddev:1922.35 (28.5%) stddev-sans-first:1881.44 09:07:40 INFO - PROCESS | 1667 | Values: 319.9 324.9 325.9 326.1 327.6 5407.6 6781.0 6829.0 6880.9 6933.2 6743.6 6773.9 6781.8 6781.8 6810.0 4737.9 4869.7 4987.2 5010.2 5021.7 4958.7 4958.9 4969.6 4980.6 4986.0 4894.8 4904.8 4924.0 4924.8 4950.1 4904.1 4923.8 4933.2 4954.8 4977.7 4236.6 4253.2 4260.9 4266.2 4271.8 5260.1 6342.7 6540.6 6595.8 6612.5 5828.0 5864.0 5875.0 5892.5 5911.1 7199.6 7209.6 7225.2 7241.9 7249.2 4687.9 4720.5 4726.0 4731.6 4745.0 7700.8 7702.9 7712.2 7719.3 7720.1 3917.4 4320.2 4670.8 4691.8 4785.8 4855.3 4855.4 4857.7 4861.5 4862.9 5722.9 5782.2 5788.1 5813.6 5871.1 7279.5 7292.5 7298.4 7302.6 7336.5 1598.6 1651.3 1655.2 1682.3 1707.8 919.2 986.4 1088.4 1099.1 1111.0 6735.7 6759.6 6804.2 6815.9 6816.4 6587.5 7001.8 7489.5 7522.4 7528.5 6724.5 6726.8 6742.9 6743.0 6769.6 3636.4 3960.5 3991.7 4001.8 4002.5 6427.2 7756.2 7780.8 7829.2 8055.1 6284.7 7859.6 7878.6 7889.5 7912.5 8008.2 8023.7 8028.8 8036.9 8040.6 7305.9 7585.2 7587.0 7615.8 7631.5 7435.6 7471.4 7477.1 7481.5 7510.0 7986.4 7996.7 8000.1 8000.8 8011.6 3969.1 4058.7 4734.7 4823.4 4836.9 6445.9 7155.4 7255.6 7541.6 7561.3 6489.0 6645.0 7207.6 7241.6 7253.1 7273.8 7294.9 7316.5 7318.1 7347.7 7104.4 7112.1 7112.5 7118.5 7141.7 7076.6 7279.4 7306.5 7338.8 7348.7 5654.5 7122.0 7136.7 7150.8 7171.2 09:07:40 INFO - PROCESS | 1667 | 09:07:40 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18464.41 Median:594.35 stddev:25735.09 (4329.9%) stddev-sans-first:25772.70 09:07:40 INFO - PROCESS | 1667 | Values: 697.1 699.6 745.7 771.0 796.3 17641.0 17863.8 17997.8 18024.5 18082.0 16414.6 16449.9 16488.0 16497.4 16521.9 731.3 874.9 931.8 946.5 948.7 934.6 936.1 941.5 947.1 949.4 996.3 998.8 1000.8 1001.9 1005.1 980.9 988.8 991.8 999.3 999.7 727.0 732.4 734.1 737.2 740.0 15658.5 15724.6 15762.3 15788.4 15802.7 12533.9 12569.8 12722.6 12728.8 12826.2 10082.8 10082.8 10101.3 10151.9 10856.9 3497.3 3536.6 3538.0 3582.5 3674.9 57854.7 78522.6 79380.4 80356.2 81007.0 7492.3 7774.5 9184.7 9307.7 9331.9 21145.9 21265.4 21315.0 21348.0 21402.1 6715.7 7041.6 7299.5 7317.1 7321.5 3924.7 3927.6 3979.6 3984.6 3995.1 3572.8 3584.4 3594.7 3602.7 3604.6 529.6 644.4 646.1 651.5 658.2 509.6 567.4 592.9 595.8 624.1 8028.8 8158.0 8196.4 8246.9 8354.5 526.3 567.0 585.4 600.3 623.0 3620.5 3683.4 3727.7 3870.0 3890.8 71650.6 95188.5 96675.0 96828.5 97082.0 81019.0 81549.6 82279.0 82546.0 84462.6 70878.6 71300.3 71466.6 72438.6 73121.9 8315.1 8320.2 8359.1 8378.5 8431.2 50484.0 51172.5 51236.0 51493.7 51921.0 61362.4 62965.8 66599.0 70134.2 71135.3 11000.3 11020.0 11055.3 11211.6 11259.2 11799.7 11962.6 12089.6 12308.4 12852.9 11256.4 11285.3 11461.8 11823.5 11904.2 11344.4 11372.1 11479.2 11757.3 12375.9 9752.8 11177.3 11373.4 11745.6 12427.6 9596.7 9752.1 9785.0 9950.1 10080.5 9337.1 9619.0 9641.8 9661.9 9735.3 09:07:40 INFO - PROCESS | 1667 | -------- Summary: end -------- 09:07:40 INFO - PROCESS | 1667 | 09:07:41 INFO - TEST-INFO | 1667: exit 0 09:07:41 INFO - TEST-OK | dromaeo_css | took 1111208ms 09:07:41 INFO - TEST-START | kraken 09:07:41 INFO - operating with platform_type : mac_ 09:07:41 INFO - Initialising browser for kraken test... 09:07:41 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpSsMBFd/profile http://localhost:49270/getInfo.html) 09:07:43 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] 09:07:44 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 09:07:44 INFO - PROCESS | 1675 | colorDepth:24 09:07:44 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 09:07:44 INFO - PROCESS | 1675 | __metrics 09:07:44 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 09:07:44 INFO - TEST-INFO | 1675: exit 0 09:07:44 INFO - Browser initialized. 09:07:44 INFO - Running cycle 1/1 for kraken test... 09:07:44 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpSsMBFd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:56 INFO - PROCESS | 1678 | RSS: Main: 255840256 09:07:56 INFO - PROCESS | 1678 | 09:07:59 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:59 INFO - PROCESS | 1678 | RSS: Main: 268345344 09:07:59 INFO - PROCESS | 1678 | 09:08:02 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 09:08:03 INFO - PROCESS | 1678 | RSS: Main: 277655552 09:08:03 INFO - PROCESS | 1678 | 09:08:06 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 09:08:07 INFO - PROCESS | 1678 | RSS: Main: 279859200 09:08:07 INFO - PROCESS | 1678 | 09:08:09 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 09:08:09 INFO - PROCESS | 1678 | RSS: Main: 280580096 09:08:09 INFO - PROCESS | 1678 | 09:08:11 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:08:12 INFO - PROCESS | 1678 | RSS: Main: 283541504 09:08:12 INFO - PROCESS | 1678 | 09:08:15 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 09:08:15 INFO - PROCESS | 1678 | RSS: Main: 284426240 09:08:15 INFO - PROCESS | 1678 | 09:08:18 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 09:08:19 INFO - PROCESS | 1678 | RSS: Main: 282783744 09:08:19 INFO - PROCESS | 1678 | 09:08:22 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 09:08:23 INFO - PROCESS | 1678 | RSS: Main: 284721152 09:08:23 INFO - PROCESS | 1678 | 09:08:25 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:08:25 INFO - PROCESS | 1678 | RSS: Main: 284450816 09:08:25 INFO - PROCESS | 1678 | 09:08:27 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:08:28 INFO - PROCESS | 1678 | RSS: Main: 284131328 09:08:28 INFO - PROCESS | 1678 | 09:08:30 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:08:31 INFO - PROCESS | 1678 | RSS: Main: 284106752 09:08:31 INFO - PROCESS | 1678 | 09:08:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:08:34 INFO - PROCESS | 1678 | RSS: Main: 283049984 09:08:34 INFO - PROCESS | 1678 | 09:08:37 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:08:37 INFO - PROCESS | 1678 | RSS: Main: 284020736 09:08:37 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 09:08:39 INFO - PROCESS | 1678 | RSS: Main: 285872128 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | __start_tp_report 09:08:39 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 09:08:39 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 09:08:39 INFO - PROCESS | 1678 | |i|pagename|runs| 09:08:39 INFO - PROCESS | 1678 | |0;ai-astar;111;109;114;114;115;127;113;119;125;121 09:08:39 INFO - PROCESS | 1678 | |1;audio-beat-detection;156;122;147;193;123;141;142;123;159;124 09:08:39 INFO - PROCESS | 1678 | |2;audio-dft;203;195;191;193;204;205;209;213;202;217 09:08:39 INFO - PROCESS | 1678 | |3;audio-fft;74;67;56;55;58;59;67;125;56;56 09:08:39 INFO - PROCESS | 1678 | |4;audio-oscillator;79;85;119;77;81;81;119;79;79;114 09:08:39 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;89;87;90;91;92;85;81;130;88;86 09:08:39 INFO - PROCESS | 1678 | |6;imaging-darkroom;98;147;153;136;153;145;95;95;95;115 09:08:39 INFO - PROCESS | 1678 | |7;imaging-desaturate;98;151;77;152;146;100;82;141;105;143 09:08:39 INFO - PROCESS | 1678 | |8;json-parse-financial;58;68;69;83;89;83;70;96;65;54 09:08:39 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;66;72;68;96;104;104;86;68;69;67 09:08:39 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;86;83;84;109;75;104;113;114;84;84 09:08:39 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;148;134;140;125;119;125;119;176;142;124 09:08:39 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;131;142;183;181;139;182;185;182;136;133 09:08:39 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;70;69;86;99;98;79;69;69;68;72 09:08:39 INFO - PROCESS | 1678 | __end_tp_report 09:08:39 INFO - PROCESS | 1678 | __start_cc_report 09:08:39 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,949 09:08:39 INFO - PROCESS | 1678 | __end_cc_report 09:08:39 INFO - PROCESS | 1678 | __startTimestamp1458144519774__endTimestamp 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | ------- Summary: start ------- 09:08:39 INFO - PROCESS | 1678 | Number of tests: 14 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:116.80 Median:117.00 stddev:5.98 (5.1%) stddev-sans-first:5.96 09:08:39 INFO - PROCESS | 1678 | Values: 111.0 109.0 114.0 114.0 115.0 127.0 113.0 119.0 125.0 121.0 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:144.50 stddev:22.48 (15.6%) stddev-sans-first:23.35 09:08:39 INFO - PROCESS | 1678 | Values: 156.0 122.0 147.0 193.0 123.0 141.0 142.0 123.0 159.0 124.0 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:203.20 Median:204.50 stddev:8.47 (4.1%) stddev-sans-first:8.98 09:08:39 INFO - PROCESS | 1678 | Values: 203.0 195.0 191.0 193.0 204.0 205.0 209.0 213.0 202.0 217.0 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:67.30 Median:58.50 stddev:21.25 (36.3%) stddev-sans-first:22.40 09:08:39 INFO - PROCESS | 1678 | Values: 74.0 67.0 56.0 55.0 58.0 59.0 67.0 125.0 56.0 56.0 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:79.00 stddev:18.14 (23.0%) stddev-sans-first:18.68 09:08:39 INFO - PROCESS | 1678 | Values: 79.0 85.0 119.0 77.0 81.0 81.0 119.0 79.0 79.0 114.0 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:88.50 stddev:13.76 (15.6%) stddev-sans-first:14.56 09:08:39 INFO - PROCESS | 1678 | Values: 89.0 87.0 90.0 91.0 92.0 85.0 81.0 130.0 88.0 86.0 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:123.20 Median:124.00 stddev:25.97 (20.9%) stddev-sans-first:25.89 09:08:39 INFO - PROCESS | 1678 | Values: 98.0 147.0 153.0 136.0 153.0 145.0 95.0 95.0 95.0 115.0 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:119.50 Median:151.50 stddev:29.87 (19.7%) stddev-sans-first:30.65 09:08:39 INFO - PROCESS | 1678 | Values: 98.0 151.0 77.0 152.0 146.0 100.0 82.0 141.0 105.0 143.0 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:73.50 Median:76.50 stddev:13.67 (17.9%) stddev-sans-first:13.30 09:08:39 INFO - PROCESS | 1678 | Values: 58.0 68.0 69.0 83.0 89.0 83.0 70.0 96.0 65.0 54.0 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:68.50 stddev:15.92 (23.2%) stddev-sans-first:16.06 09:08:39 INFO - PROCESS | 1678 | Values: 66.0 72.0 68.0 96.0 104.0 104.0 86.0 68.0 69.0 67.0 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:83.50 stddev:14.65 (17.5%) stddev-sans-first:15.27 09:08:39 INFO - PROCESS | 1678 | Values: 86.0 83.0 84.0 109.0 75.0 104.0 113.0 114.0 84.0 84.0 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:137.00 stddev:17.50 (12.8%) stddev-sans-first:17.94 09:08:39 INFO - PROCESS | 1678 | Values: 148.0 134.0 140.0 125.0 119.0 125.0 119.0 176.0 142.0 124.0 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:181.50 stddev:24.65 (13.6%) stddev-sans-first:23.91 09:08:39 INFO - PROCESS | 1678 | Values: 131.0 142.0 183.0 181.0 139.0 182.0 185.0 182.0 136.0 133.0 09:08:39 INFO - PROCESS | 1678 | 09:08:39 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.90 Median:75.50 stddev:12.24 (16.2%) stddev-sans-first:12.65 09:08:39 INFO - PROCESS | 1678 | Values: 70.0 69.0 86.0 99.0 98.0 79.0 69.0 69.0 68.0 72.0 09:08:39 INFO - PROCESS | 1678 | -------- Summary: end -------- 09:08:39 INFO - PROCESS | 1678 | 09:08:40 INFO - TEST-INFO | 1678: exit 0 09:08:40 INFO - TEST-OK | kraken | took 59365ms 09:08:40 INFO - SUITE-END | took 1170s 09:08:40 INFO - Completed test suite (00:19:30) 09:08:40 INFO - javascript benchmark 09:08:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3534.982325088374, 3535.010197144799, 3571.9642803571974, 3591.8024508652047, 3636.1273294409334, 5902.616329938551, 5915.378885217055, 5918.940810591893, 5924.637969149753, 5942.168096466493, 5786.479216870481, 5895.6462612243295, 5954.464098231169, 5964.0, 6060.999935010718, 5313.495217954288, 5371.435999220084, 5372.758225879845, 5392.811251606195, 5483.451654834505, 150.55965667801033, 5365.3293338332705, 5398.163284690879, 5402.8919421611545, 5458.781648734046, 5354.437784032679, 5357.866053348658, 5367.704776237305, 5381.730913454312, 5394.7842086316505, 5295.761690723926, 5381.838544843661, 5426.240326354314, 5442.564594832404, 5453.836384908459, 5271.28837606922, 5300.363956325227, 5336.119540275849, 5373.247745315659, 5420.051490989061, 4527.728336299832, 5774.2782152230975, 5790.10253410722, 5812.157237200582, 5876.6180198286975, 6152.538559608047, 6176.81469555914, 6294.968525157345, 6303.653299068549, 6304.211973503312, 6236.688165591702, 6288.591241569329, 6308.2745484269435, 6309.148264984215, 6317.241930968313, 5997.310309314441, 6020.879582408327, 6024.48791852693, 6046.667433291123, 6055.7593690334415, 5075.441701412841, 5370.973145134328, 5700.778367899927, 6450.161479007793, 6450.935490645127, 5149.871253218699, 6258.718357673915, 6286.18279623646, 6298.685065746694, 6301.684915754194, 5182.714950677673, 6248.28144763349, 6267.6866156691985, 6317.399847014526, 6333.714982825784, 5187.455317191716, 6147.985582378947, 6201.503879689614, 6289.654069026156, 6308.116863639094, 5243.5542978847225, 6112.07796728157, 6220.098085777628, 6267.874642507124, 6288.371162883675, 4966.553010229024, 5000.39995200571, 5048.697078175322, 5052.6715763475995, 5097.209932460474, 4438.289873620205, 4479.731216126977, 4535.931961020588, 4545.931811022837, 4572.314152877095, 5009.899802004013, 6018.21763170785, 6029.788957386558, 6073.0, 6092.39076092396, 6310.337414571404, 6366.0, 6371.553991220663, 6372.107904893319, 6387.712552935129, 4968.552830245295, 5929.110633405024, 5994.850128746816, 6079.452849243589, 6130.846728831726, 5473.808416705396, 5476.698781567052, 5493.368262649767, 5520.089185284383, 5533.253010843565, 6356.4279214870885, 6568.704408301638, 6575.736970521126, 6576.539642225094, 6580.967095164589, 6245.718942647501, 6299.401556852092, 6314.368563143833, 6314.684265786784, 6329.1139240505445, 6324.367563243639, 6359.586626869239, 6380.106785050004, 6387.425131738166, 6388.93611063902, 6105.206323178136, 6117.174181485442, 6150.200473938359, 6174.44430001302, 6231.906521402092, 6171.290301615371, 6266.811995640138, 6351.0, 6356.396142366468, 6361.4274715274, 6198.659073750987, 6221.813345599639, 6241.469475094668, 6244.406781355764, 6244.68776561161, 6106.673025714385, 6187.102870083902, 6216.191895053614, 6216.813495595139, 6232.532560057924, 5340.626156169031, 5367.0, 5781.682007489629, 5956.553258505716, 6136.641621527207, 6214.5028397727165, 6235.812925612239, 6288.874222515433, 6291.307956124914, 6298.622082675054, 6055.909161362495, 6081.331053584191, 6129.049997250433, 6167.013277875519, 6210.0], "unit": "score", "name": "dojo.html", "value": 5736.544527767516}, {"lowerIsBetter": false, "replicates": [428.47083851443483, 597.4891467795035, 601.9578629495937, 636.7866764633848, 651.605778504005, 37477.81261093694, 37894.052648683726, 38082.8095859521, 38095.0, 38220.426693599584, 33396.499052514235, 39274.41088383677, 39316.01709957253, 39558.0, 39953.00117497064, 7560.886586701204, 9409.623615055407, 9621.95189024054, 9636.518174091267, 9869.70390888271, 9502.907165675966, 9731.36746111504, 9764.804703905918, 9823.95088024559, 9835.262355323344, 8461.815345851586, 9613.942466328699, 9801.656942007032, 9850.901490985107, 9858.605655773796, 9707.271954603433, 9756.4633945133, 9832.26258030647, 9837.606495740161, 9851.211903047739, 9595.472249026301, 9678.806423871483, 9693.70918872435, 9717.805643887154, 9764.90235097647, 32201.0, 37993.62006379929, 38460.42309365362, 38770.41844372336, 38804.22391552181, 3103.2707313781243, 3203.743700503954, 3207.7914935529116, 3384.7461440392067, 3491.9650803491895, 23169.652455213185, 27476.862615686994, 27793.86103069492, 28467.0, 28804.8559757202, 2679.879405426741, 2711.0646826844904, 2713.782897368206, 2717.184844546648, 2867.971320286791, 398954.0, 412791.0, 420082.0, 420910.58178836555, 423587.9999999969, 45025.77487112543, 59838.0, 60006.0, 60022.099668505005, 60023.69988150031, 44691.553084469386, 44706.43527476523, 45006.09987800226, 45062.77468612701, 45146.32280515795, 15442.768358474632, 15652.139132347831, 15930.92034539843, 15941.202939852961, 16021.839781602268, 12248.693782655326, 12661.240325580495, 12706.237625742486, 12789.168704034208, 12845.550405735941, 11954.581589644495, 12012.819807702892, 14362.353694083582, 14672.706545869236, 14824.0, 5478.45215478449, 6573.474122070223, 6646.26891041985, 6684.131062961784, 6685.829979753524, 930.283681565191, 949.9525023748923, 952.5999080386255, 978.9461579613189, 1031.865857438528, 23258.65112023321, 29161.854190729337, 29316.267093322836, 29840.0, 30166.547501787492, 921.6083164654995, 1098.6374496416324, 1119.2221406122667, 1171.666075168573, 1188.1623455463878, 15218.0, 16391.91804040996, 16569.751453728204, 16579.0, 16824.91587542079, 631249.0, 635387.0, 640510.0, 640574.0, 642061.0, 61085.77828443406, 61124.777504450554, 61530.0770488443, 61560.38439615636, 61603.69198153981, 1403.6140061483175, 1468.3319089814108, 1471.1540864003027, 1479.6300924768807, 1480.8445113263167, 29925.700742992292, 30269.394612107193, 30352.54471182978, 30439.54340684936, 30759.846200768854, 50797.49202507928, 51198.232026520374, 51759.22361164661, 51817.7409112952, 51865.481345187574, 500791.0, 513493.0, 517029.0, 518979.0, 519206.0, 31952.36095278128, 32712.855050073133, 32751.508727368633, 33066.66933330732, 33132.0, 43341.69974900758, 43446.524278058314, 44105.77947110244, 45308.32037519506, 45379.54620453753, 29566.408671826874, 34331.65668343285, 34911.65088349186, 36078.0, 36950.0, 28615.42769144647, 30555.2361190972, 34719.82640086884, 36466.0, 38014.429783553824, 35813.64186358103, 35874.820625896704, 36645.63354366422, 36698.8165059173, 36745.816270919546, 26581.069662561717, 28807.855960720062, 29591.852040739657, 31895.0, 32213.838930805196, 24008.039678412668, 24138.275851724477, 24494.63258051166, 24594.50810983806, 24601.384965376008], "unit": "score", "name": "ext.html", "value": 19036.6459256077}, {"lowerIsBetter": false, "replicates": [356.5436241610739, 360.644764906567, 366.6132230496826, 369.74487603553564, 370.9035650730811, 19061.23755049798, 19455.0, 20038.29865954692, 20259.59480810383, 20315.593688126228, 20001.199952001938, 20391.796082039175, 20548.0, 20562.383128506168, 20578.588428231466, 5695.971520142404, 5985.0, 5985.16207730918, 6015.458608725214, 6018.247719035121, 4244.405783190356, 5870.794522191724, 6257.968710156443, 6526.412622863942, 6565.277819439858, 6432.485401167895, 6467.256265529454, 6472.255690595594, 6486.805395838132, 6489.772857949973, 5012.423571289312, 5401.837944861661, 5676.631018983794, 5682.346530149044, 5709.685967271798, 5323.946760532383, 5346.117890548055, 5423.430539793304, 5427.565794736412, 5447.618666693333, 12652.493900243979, 13108.934455327662, 13121.540746073937, 13252.337383130805, 13360.799588006188, 1998.1907327532372, 2090.6550419180817, 2129.4782778219437, 2244.696965909614, 2664.5603475426533, 9947.303688741718, 10749.647801434692, 11503.849615038513, 14153.575392738234, 14574.927125364306, 1409.9083559568596, 1588.2217713320506, 1695.6862980348676, 1700.5493544210794, 1720.6558688262398, 63251.68374158146, 75441.49117017629, 80718.98202544983, 96165.0, 98120.0, 11014.39420831862, 11167.944160279147, 11281.887181128248, 11307.265027773168, 11444.94277528607, 13433.26117063571, 13518.0, 13518.324083795771, 13535.187888726708, 13603.863961360457, 8344.874826877602, 8518.190771876662, 8555.871661925075, 8593.742187734253, 8619.310455163697, 8588.22705956467, 8627.95686021566, 8643.654253829776, 8648.870266946002, 8722.0, 3564.4475106358555, 4371.672124590668, 4457.866264012085, 4518.819247230074, 4558.111168322212, 1739.2608141539795, 1822.4623735997911, 1843.6404901044436, 1844.9446516604523, 1868.747719057937, 909.7498187998222, 943.1464524605243, 948.3314263444255, 963.5037955452947, 963.7542426681291, 13611.0, 18677.533061673294, 19013.42959711211, 19110.33113841009, 19210.903945480182, 842.0905422144069, 996.7458298133929, 997.2769741937183, 1020.3112898793285, 1022.5143057047992, 10559.0, 10751.354918704903, 10765.569377224823, 10799.136069114453, 10877.401742904058, 592909.0, 596506.0174699186, 597704.0, 604741.0, 614514.0, 78571.21428785754, 99349.01301974064, 105763.0, 106525.0, 107625.0, 1029.0429900192892, 1033.1528146919604, 1034.0796690945215, 1039.3296323871211, 1039.6932904793105, 17179.0, 17370.131493425026, 17567.560810979827, 17760.200790964696, 17966.101694915462, 46812.0, 47395.76302118467, 47429.0, 47703.28445073257, 49210.27764028242, 63814.68092659693, 64968.35031649812, 67055.99416008861, 67451.3254867445, 69479.0, 7218.133823941161, 7282.635868206463, 7350.852982940204, 7523.134839493309, 7627.656755445907, 10934.56261749521, 11062.944685276521, 11706.0, 11804.76390472203, 12076.456559455022, 10088.899111008795, 10142.985701429798, 10289.691309260734, 10328.896711032794, 10350.844737329096, 8439.704610338855, 8753.255973242345, 9538.85691714611, 9889.752756180866, 10288.897111029093, 10278.430392401899, 10437.373757574569, 10527.052565269163, 10559.0, 10643.787124257626, 7172.892406614009, 7274.054372931697, 7382.187959324578, 7523.623818809147, 7615.086189657277, 9993.600255989679, 10283.07452329294, 10358.844617330897, 10570.630027948984, 10579.576816927236], "unit": "score", "name": "jquery.html", "value": 8928.292552014393}, {"lowerIsBetter": false, "replicates": [1385.4527461652647, 1604.2620394618475, 1866.2814816295731, 2002.6995950607406, 2018.788027257137, 7312.561246325225, 7899.684012639487, 8530.829383412329, 8701.08638592948, 8931.285497160228, 7102.928970710304, 8638.179372959574, 8658.090900455456, 8754.912450875489, 8786.209241168293, 2453.264020793764, 2476.1333533263305, 2481.0323973650293, 2485.763852434016, 2490.8380955237944, 2425.8908349124245, 2483.205374280231, 2487.577111890983, 2490.0537795637633, 2509.3099397665605, 2084.81236688698, 2472.221250306157, 2482.5283196192754, 2487.440325926661, 2527.4818662174303, 2440.048381131369, 2442.474867903409, 2482.714487833904, 2488.776010159085, 2514.019532382354, 2445.4986727720775, 2468.8148388870904, 2509.0841842727455, 2512.459821138464, 2516.169664010872, 6388.0, 8813.206811387006, 8837.690680826141, 8848.115188481164, 8862.42394244372, 4654.4647365553055, 5420.783168673248, 5517.089680202762, 5545.889082218373, 5550.639208451437, 3586.0, 3627.220147668264, 3688.5573731152435, 3762.3792074307707, 3773.792441415721, 1039.4335087377397, 1058.925875188737, 1061.1669839176286, 1062.8671416072991, 1067.5783065689009, 11636.360000199986, 11802.704932376759, 11819.34993575353, 11843.940780296129, 11844.34856082915, 4094.7747873867224, 4918.532739389752, 4952.727599981963, 4955.231939049381, 5042.773075211624, 10090.142337901361, 10145.442000690033, 10191.643292484727, 10199.337043092175, 10202.795944081077, 5487.42382049887, 5556.222128901957, 5562.888742225133, 5589.5807814413265, 5591.916121258185, 3691.8154092295276, 3961.7622942623534, 4997.550220480174, 5027.698338099725, 5051.4695956924725, 2556.4120252342063, 2711.0209547030386, 3942.172143849766, 3982.5818289079807, 4029.959700403017, 1318.156379916854, 1329.9135556188817, 1337.0172922901659, 1340.517413731056, 1342.2617560341773, 1125.8254970479588, 1128.058071510298, 1138.5445821671399, 1321.5837011341396, 1427.3862239237021, 8160.714374996846, 8254.215849494289, 8292.212239837207, 8357.665693372319, 8385.371097167616, 510.81865937592363, 516.767454645411, 516.8371962831771, 519.6855902179203, 522.2114606943543, 6088.543359248074, 6100.3899610039525, 6159.876802463926, 6218.782342617987, 6221.595596286227, 10125.291229613857, 10323.277370584137, 10378.948105259426, 10394.0, 10445.11216546602, 8399.328053755686, 10071.748206294902, 10242.53908574116, 10266.435346055889, 10369.792604147875, 8227.465214761021, 8407.117252688502, 8426.578671066422, 8479.533625650649, 8488.915110848937, 8080.232377924088, 8084.868118463537, 8092.757217283491, 8142.796430089058, 8359.247667709935, 9378.624855005723, 9458.385204961656, 9691.5154242289, 9761.755956101155, 9788.510574471391, 8068.7579372616565, 9695.369800962915, 9812.264080194156, 9977.50112494358, 9991.0, 6663.13379260693, 7430.182679905314, 7566.394688425023, 7705.113911899979, 7736.8452630948195, 8223.794405139919, 8280.58597070156, 8320.542370169698, 8371.95814020926, 8380.078191399063, 7304.086989126359, 7379.446541509516, 7381.44639152055, 7568.0, 7620.542767433972, 5844.649321040752, 6762.917933130676, 6827.873400888798, 7245.2030276670575, 7363.926360736324, 6326.715297811702, 6833.282505336868, 7613.467057305936, 7765.22347765219, 7782.49413788102, 6249.718762655601, 6488.416042556192, 6939.861202776017, 6964.1643002837955, 7008.894866576903, 5861.9413805861395, 7063.6821343038655, 7102.289771022856, 7135.143782746104, 7147.392471639969], "unit": "score", "name": "mootools.html", "value": 4778.407880343632}, {"lowerIsBetter": false, "replicates": [319.87684741374574, 324.9447593909035, 325.8924554896884, 326.1227298566856, 327.6068717538953, 5407.648502847322, 6781.0, 6828.951314605617, 6880.8967865482055, 6933.168019837614, 6743.561668491545, 6773.864522709543, 6781.76263830766, 6781.796546103613, 6810.0, 4737.928931066037, 4869.659123861331, 4987.177115775893, 5010.198368261079, 5021.673591216569, 4958.652894297401, 4958.925616115761, 4969.577585905203, 4980.601551875841, 4985.975070124662, 4894.8286809961655, 4904.803807847682, 4923.9753801230945, 4924.842661974433, 4950.059488697136, 4904.06822703687, 4923.82766603169, 4933.235348520967, 4954.752262386866, 4977.701337919701, 4236.6187043165955, 4253.171136411342, 4260.9147817043795, 4266.168097221043, 4271.786410679453, 5260.105782017028, 6342.746290148435, 6540.607563546202, 6595.8021259362295, 6612.471002319803, 5827.970860145672, 5863.9738045841805, 5874.970625146847, 5892.499137573312, 5911.083782013795, 7199.6040217788, 7209.639518024078, 7225.241349658263, 7241.927580724178, 7249.16634587024, 4687.88280292992, 4720.504347043579, 4725.9527404726205, 4731.550502702238, 4744.976275118637, 7700.768976930645, 7702.8844567331535, 7712.228777122299, 7719.34385577221, 7720.07359116904, 3917.3928041153667, 4320.200762858881, 4670.789814458358, 4691.835785747482, 4785.784639691222, 4855.271709243641, 4855.4173499179615, 4857.684250523705, 4861.538153875376, 4862.878428039327, 5722.942770572325, 5782.161586569924, 5788.0739081746715, 5813.633796057923, 5871.089981052944, 7279.526830755984, 7292.45306602007, 7298.379637730746, 7302.56184628924, 7336.486445948839, 1598.5683865356289, 1651.265186991801, 1655.1641421082277, 1682.3354774864106, 1707.7523759054868, 919.2324409118328, 986.3588667366126, 1088.4435257581733, 1099.14816017587, 1110.9777804443866, 6735.663216839139, 6759.628220447824, 6804.217514985741, 6815.897761533581, 6816.386525212754, 6587.538872278895, 7001.824954376181, 7489.475736698379, 7522.398208143445, 7528.473006889575, 6724.462043036546, 6726.7981960541265, 6742.932570674328, 6743.0, 6769.559978601375, 3636.4181730922924, 3960.5445373782386, 3991.660708839723, 4001.8199181036925, 4002.459667944848, 6427.22873255203, 7756.224377562198, 7780.766577002699, 7829.177936316605, 8055.073666528424, 6284.685765711696, 7859.567723775247, 7878.566678832604, 7889.526628402315, 7912.525248485109, 8008.239217274349, 8023.719169828912, 8028.759137225892, 8036.919630803617, 8040.638171282307, 7305.926940730525, 7585.165631780389, 7586.962065189638, 7615.809604759926, 7631.519756079408, 7435.553866768011, 7471.402287816853, 7477.102747670315, 7481.513701609378, 7509.962450187714, 7986.440949133737, 7996.680132794856, 8000.079990800899, 8000.759977200693, 8011.599420029092, 3969.146633473817, 4058.675305975574, 4734.692245004064, 4823.3729615149805, 4836.854894353175, 6445.871082578228, 7155.42756579462, 7255.600941948243, 7541.6229188539255, 7561.319481246494, 6489.0, 6645.0, 7207.639618019183, 7241.601711905896, 7253.093363329584, 7273.781786546412, 7294.927050729425, 7316.524425912298, 7318.121825380988, 7347.742829001173, 7104.431645468247, 7112.075430194249, 7112.537685050455, 7118.466115041289, 7141.678624462015, 7076.646167691698, 7279.381252593589, 7306.4885458017425, 7338.816529586803, 7348.70605175787, 5654.547636189177, 7122.0, 7136.678849451683, 7150.821229469305, 7171.247019062923], "unit": "score", "name": "prototype.html", "value": 5257.118167335606}, {"lowerIsBetter": false, "replicates": [697.0728930522406, 699.6431819771918, 745.6830846890072, 770.9845803083939, 796.311190819941, 17641.0, 17863.82136178641, 17997.820021799776, 18024.54938626535, 18082.0, 16414.589635259093, 16449.91775041126, 16488.01071935682, 16497.422590209346, 16521.91739041303, 731.297953964195, 874.8600223964168, 931.8415869302218, 946.5361972633394, 948.7011591348737, 934.6168071090854, 936.148105224246, 941.4821847983616, 947.0955237747969, 949.4208532794989, 996.3374356053216, 998.8002399520088, 1000.8398656215007, 1001.944893030883, 1005.0753306957616, 980.9362391444569, 988.8220120378329, 991.8165139449225, 999.3154689038032, 999.7200783780553, 727.0221552012534, 732.4250463386217, 734.111724812977, 737.2185483387626, 740.0305599664457, 15658.451954181663, 15724.606884827856, 15762.290696918666, 15788.447404340908, 15802.683946321124, 12533.874661253452, 12569.811452828124, 12722.554710585086, 12728.80906786399, 12826.230426174367, 10082.798344033079, 10082.798344033079, 10101.292909496338, 10151.898481015169, 10856.891431085667, 3497.265574229415, 3536.6286539913453, 3537.964620353789, 3582.5342705448384, 3674.8713795017047, 57854.710726446516, 78522.60738696327, 79380.41239175184, 80356.19643803604, 81007.0, 7492.250774922573, 7774.494657847222, 9184.724458266262, 9307.674231401868, 9331.90668093324, 21145.894270528857, 21265.36203913885, 21315.0, 21348.0, 21402.143914243567, 6715.664216789141, 7041.5775053496955, 7299.489035767551, 7317.12194536659, 7321.450891183183, 3924.7056470764805, 3927.626875446828, 3979.621935916083, 3984.6452206250015, 3995.10110225197, 3572.7677700949357, 3584.390653588896, 3594.6944509716445, 3602.6757591816863, 3604.621514740967, 529.6027979015738, 644.432899048834, 646.0954663471178, 651.501601275025, 658.1674182159572, 509.6228790694859, 567.3560508822516, 592.8843875444247, 595.8182754259992, 624.1449214575969, 8028.83942321162, 8158.0, 8196.42625016243, 8246.876296855551, 8354.540500272422, 526.3420724094882, 567.0332083797116, 585.3736501942881, 600.2916558461058, 623.0342968398963, 3620.475031120473, 3683.4106542953, 3727.683146932541, 3869.9613003870163, 3890.7860067696547, 71650.64174679093, 95188.52405737927, 96675.033249668, 96828.51585742168, 97082.0, 81019.0, 81549.59225203954, 82279.0, 82546.0, 84462.57768711117, 70878.64560677164, 71300.28699712937, 71466.64266678633, 72438.63780681063, 73121.90317145248, 8315.085340612648, 8320.209580089882, 8359.080501144748, 8378.53918034514, 8431.241188293083, 50484.0, 51172.46482605528, 51235.975280494924, 51493.71265718237, 51921.0, 61362.38637613567, 62965.79619713288, 66599.0, 70134.24664383431, 71135.28864711494, 11000.339979601249, 11019.953104455064, 11055.28140670886, 11211.55153793839, 11259.211855170059, 11799.705007374885, 11962.58130965412, 12089.637310880336, 12308.384580771104, 12852.871471285167, 11256.437178141225, 11285.322880627189, 11461.770764584495, 11823.52705891789, 11904.226225295328, 11344.432778361213, 11372.147088968526, 11479.196456247982, 11757.294562326288, 12375.938120309702, 9752.756181095245, 11177.329360238411, 11373.374464404536, 11745.647630571097, 12427.627171184879, 9596.712098637052, 9752.073553012453, 9784.951075244579, 9950.054744799232, 10080.495975201064, 9337.112974267433, 9619.0, 9641.807163856824, 9661.855072173783, 9735.318527703275], "unit": "score", "name": "yui.html", "value": 7002.239470912821}], "name": "dromaeo_css", "value": 7453.925311660645}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 114.0, 114.0, 115.0, 127.0, 113.0, 119.0, 125.0, 121.0], "unit": "score", "name": "ai-astar", "value": 116.8}, {"lowerIsBetter": true, "replicates": [156.0, 122.0, 147.0, 193.0, 123.0, 141.0, 142.0, 123.0, 159.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.0}, {"lowerIsBetter": true, "replicates": [203.0, 195.0, 191.0, 193.0, 204.0, 205.0, 209.0, 213.0, 202.0, 217.0], "unit": "score", "name": "audio-dft", "value": 203.2}, {"lowerIsBetter": true, "replicates": [74.0, 67.0, 56.0, 55.0, 58.0, 59.0, 67.0, 125.0, 56.0, 56.0], "unit": "score", "name": "audio-fft", "value": 67.3}, {"lowerIsBetter": true, "replicates": [79.0, 85.0, 119.0, 77.0, 81.0, 81.0, 119.0, 79.0, 79.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 91.3}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 90.0, 91.0, 92.0, 85.0, 81.0, 130.0, 88.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.9}, {"lowerIsBetter": true, "replicates": [98.0, 147.0, 153.0, 136.0, 153.0, 145.0, 95.0, 95.0, 95.0, 115.0], "unit": "score", "name": "imaging-darkroom", "value": 123.2}, {"lowerIsBetter": true, "replicates": [98.0, 151.0, 77.0, 152.0, 146.0, 100.0, 82.0, 141.0, 105.0, 143.0], "unit": "score", "name": "imaging-desaturate", "value": 119.5}, {"lowerIsBetter": true, "replicates": [58.0, 68.0, 69.0, 83.0, 89.0, 83.0, 70.0, 96.0, 65.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 73.5}, {"lowerIsBetter": true, "replicates": [66.0, 72.0, 68.0, 96.0, 104.0, 104.0, 86.0, 68.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 80.0}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 84.0, 109.0, 75.0, 104.0, 113.0, 114.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.6}, {"lowerIsBetter": true, "replicates": [148.0, 134.0, 140.0, 125.0, 119.0, 125.0, 119.0, 176.0, 142.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 135.2}, {"lowerIsBetter": true, "replicates": [131.0, 142.0, 183.0, 181.0, 139.0, 182.0, 185.0, 182.0, 136.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 159.4}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 86.0, 99.0, 98.0, 79.0, 69.0, 69.0, 68.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.9}], "name": "kraken", "value": 1575.8}]} 09:08:41 INFO - Return code: 0 09:08:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:08:41 ERROR - # TBPL SUCCESS # 09:08:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:08:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:08:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:08:41 INFO - 2016-03-16 09:08:41.077 screenresolution[1683:10661] starting screenresolution argv=screenresolution get 09:08:41 INFO - 2016-03-16 09:08:41.080 screenresolution[1683:10661] Display 0: 1600x1200x32@60 09:08:41 INFO - 2016-03-16 09:08:41.086 screenresolution[1684:10664] starting screenresolution argv=screenresolution list 09:08:41 INFO - Available Modes on Display 0 09:08:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:08:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:08:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:08:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:08:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:08:41 INFO - Intel Iris: 09:08:41 INFO - Chipset Model: Intel Iris 09:08:41 INFO - Type: GPU 09:08:41 INFO - Bus: Built-In 09:08:41 INFO - VRAM (Dynamic, Max): 1536 MB 09:08:41 INFO - Vendor: Intel (0x8086) 09:08:41 INFO - Device ID: 0x0a2e 09:08:41 INFO - Revision ID: 0x0009 09:08:41 INFO - Displays: 09:08:41 INFO - Display: 09:08:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:08:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:08:41 INFO - Display Serial Number: 1600x1200 60 09:08:41 INFO - Main Display: Yes 09:08:41 INFO - Mirror: Off 09:08:41 INFO - Online: Yes 09:08:41 INFO - Rotation: Supported 09:08:41 INFO - Return code: 0 09:08:41 INFO - Running post-action listener: _resource_record_post_action 09:08:41 INFO - Running post-run listener: _resource_record_post_run 09:08:42 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39347712; Write bytes: 707751424; Read time: 442; Write time: 2023 09:08:42 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403042816; Write bytes: 396062208; Read time: 30093; Write time: 820 09:08:42 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 32243200; Write bytes: 298532864; Read time: 346; Write time: 1166 09:08:42 INFO - Running post-run listener: _upload_blobber_files 09:08:42 INFO - Blob upload gear active. 09:08:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:08:42 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 09:08:42 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'] 09:08:42 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 09:08:42 INFO - (blobuploader) - INFO - Open directory for files ... 09:08:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:08:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:08:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:44 INFO - (blobuploader) - INFO - Done attempting. 09:08:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:08:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:08:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:45 INFO - (blobuploader) - INFO - Done attempting. 09:08:45 INFO - (blobuploader) - INFO - Iteration through files over. 09:08:45 INFO - Return code: 0 09:08:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:08:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:08:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b60fca28a8a6602d11aedbe3b679bf962499662d14ebaee047bea242184257a2c92aca2f34cc3f96c1c66ea707d778bde8f56fe4ce23e2aef52d1bc43df6aacf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf69522c1d44cb346bc27791731718b340bc1570bf2fc4ed0b66628b38d013709cf516ac8016e736e74cf1a8a6a5fc709c65daac818ac6bf4ae39da0b308d4ec"} 09:08:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:08:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:08:45 INFO - Contents: 09:08:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b60fca28a8a6602d11aedbe3b679bf962499662d14ebaee047bea242184257a2c92aca2f34cc3f96c1c66ea707d778bde8f56fe4ce23e2aef52d1bc43df6aacf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf69522c1d44cb346bc27791731718b340bc1570bf2fc4ed0b66628b38d013709cf516ac8016e736e74cf1a8a6a5fc709c65daac818ac6bf4ae39da0b308d4ec"} 09:08:45 INFO - Running post-run listener: copy_logs_to_upload_dir 09:08:45 INFO - Copying logs to upload dir... 09:08:45 INFO - mkdir: /builds/slave/test/build/upload/logs 09:08:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.341626 ========= master_lag: 21.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-03-16 09:09:06.602574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 14 secs) (at 2016-03-16 09:09:06.603570) ========= 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.vbJnTeHPQm/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.efxHMadUUw/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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/b60fca28a8a6602d11aedbe3b679bf962499662d14ebaee047bea242184257a2c92aca2f34cc3f96c1c66ea707d778bde8f56fe4ce23e2aef52d1bc43df6aacf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf69522c1d44cb346bc27791731718b340bc1570bf2fc4ed0b66628b38d013709cf516ac8016e736e74cf1a8a6a5fc709c65daac818ac6bf4ae39da0b308d4ec"} build_url:https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011103 build_url: 'https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/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/b60fca28a8a6602d11aedbe3b679bf962499662d14ebaee047bea242184257a2c92aca2f34cc3f96c1c66ea707d778bde8f56fe4ce23e2aef52d1bc43df6aacf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf69522c1d44cb346bc27791731718b340bc1570bf2fc4ed0b66628b38d013709cf516ac8016e736e74cf1a8a6a5fc709c65daac818ac6bf4ae39da0b308d4ec"}' ========= master_lag: 14.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 14 secs) (at 2016-03-16 09:09:20.769266) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 28 secs) (at 2016-03-16 09:09:20.769561) ========= 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.vbJnTeHPQm/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.efxHMadUUw/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005310 ========= master_lag: 28.71 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 28 secs) (at 2016-03-16 09:09:49.480695) ========= ========= Started reboot skipped (results: 3, elapsed: 11 secs) (at 2016-03-16 09:09:49.481037) ========= ========= Finished reboot skipped (results: 3, elapsed: 11 secs) (at 2016-03-16 09:10:01.037945) ========= ========= Total master_lag: 64.56 =========