builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0140 starttime: 1458231517.7 results: success (0) buildid: 20160317072216 builduid: 234dfa4a45ec4b8ab7952061b1627dec revision: 5781664ff8a9a00fadb1349af3ae1487fdea94df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:37.701521) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:37.701937) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:37.702222) ========= 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.fR1lPDCOpf/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.WODF0XjIG8/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005080 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:37.727258) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:37.727524) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:37.744174) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:37.744496) ========= 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.fR1lPDCOpf/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.WODF0XjIG8/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005323 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:37.794198) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:37.794470) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:37.794806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:37.795079) ========= 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.fR1lPDCOpf/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.WODF0XjIG8/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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-17 09:18:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 156M=0s 2016-03-17 09:18:37 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102001 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:37.917798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:37.918069) ========= 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.fR1lPDCOpf/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.WODF0XjIG8/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.020246 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:37.975573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 09:18:37.975923) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5781664ff8a9a00fadb1349af3ae1487fdea94df --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5781664ff8a9a00fadb1349af3ae1487fdea94df --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fR1lPDCOpf/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.WODF0XjIG8/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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-17 09:18:38,091 truncating revision to first 12 chars 2016-03-17 09:18:38,091 Setting DEBUG logging. 2016-03-17 09:18:38,091 attempt 1/10 2016-03-17 09:18:38,091 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5781664ff8a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 09:18:39,346 unpacking tar archive at: mozilla-aurora-5781664ff8a9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.505009 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 09:18:39.501935) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:39.502812) ========= echo 5781664ff8a9a00fadb1349af3ae1487fdea94df in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5781664ff8a9a00fadb1349af3ae1487fdea94df'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fR1lPDCOpf/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.WODF0XjIG8/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 5781664ff8a9a00fadb1349af3ae1487fdea94df program finished with exit code 0 elapsedTime=0.005071 script_repo_revision: '5781664ff8a9a00fadb1349af3ae1487fdea94df' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:39.557168) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:39.557922) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 09:18:39.574438) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-17 09:18:39.575148) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fR1lPDCOpf/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.WODF0XjIG8/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 09:18:39 INFO - MultiFileLogger online at 20160317 09:18:39 in /builds/slave/test 09:18:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:18:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:18:39 INFO - {'append_to_log': False, 09:18:39 INFO - 'base_work_dir': '/builds/slave/test', 09:18:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:18:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:18:39 INFO - 'branch': 'Mozilla-Aurora', 09:18:39 INFO - 'buildbot_json_path': 'buildprops.json', 09:18:39 INFO - 'config_files': ('talos/mac_config.py',), 09:18:39 INFO - 'default_actions': ('clobber', 09:18:39 INFO - 'read-buildbot-config', 09:18:39 INFO - 'download-and-extract', 09:18:39 INFO - 'populate-webroot', 09:18:39 INFO - 'create-virtualenv', 09:18:39 INFO - 'install', 09:18:39 INFO - 'run-tests'), 09:18:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:18:39 INFO - 'download_minidump_stackwalk': True, 09:18:39 INFO - 'download_symbols': 'ondemand', 09:18:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:18:39 INFO - 'tooltool.py': '/tools/tooltool.py', 09:18:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:18:39 INFO - '/tools/misc-python/virtualenv.py')}, 09:18:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:18:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:18:39 INFO - 'installer_path': 'installer.exe', 09:18:39 INFO - 'log_level': 'info', 09:18:39 INFO - 'log_name': 'talos', 09:18:39 INFO - 'log_to_console': True, 09:18:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:18:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:18:39 INFO - 'opt_config_files': (), 09:18:39 INFO - 'pip_index': False, 09:18:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:18:39 INFO - 'cmd': ('bash', 09:18:39 INFO - '-c', 09:18:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:18:39 INFO - 'enabled': True, 09:18:39 INFO - 'halt_on_failure': False, 09:18:39 INFO - 'name': 'check_screen_resolution'},), 09:18:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:18:39 INFO - 'cmd': ('bash', 09:18:39 INFO - '-c', 09:18:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:18:39 INFO - 'enabled': True, 09:18:39 INFO - 'halt_on_failure': False, 09:18:39 INFO - 'name': 'check_screen_resolution'},), 09:18:39 INFO - 'run_cmd_checks_enabled': True, 09:18:39 INFO - 'sps_profile': False, 09:18:39 INFO - 'sps_profile_interval': 0, 09:18:39 INFO - 'suite': 'dromaeojs-e10s', 09:18:39 INFO - 'system_bits': '32', 09:18:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:18:39 INFO - 'title': 't-yosemite-r7-0140', 09:18:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:18:39 INFO - 'use_talos_json': True, 09:18:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:18:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:18:39 INFO - 'work_dir': 'build'} 09:18:39 INFO - ##### 09:18:39 INFO - ##### Running clobber step. 09:18:39 INFO - ##### 09:18:39 INFO - Running pre-action listener: _resource_record_pre_action 09:18:39 INFO - Running main action method: clobber 09:18:39 INFO - rmtree: /builds/slave/test/build 09:18:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:18:40 INFO - Running post-action listener: _resource_record_post_action 09:18:40 INFO - ##### 09:18:40 INFO - ##### Running read-buildbot-config step. 09:18:40 INFO - ##### 09:18:40 INFO - Running pre-action listener: _resource_record_pre_action 09:18:40 INFO - Running main action method: read_buildbot_config 09:18:40 INFO - Using buildbot properties: 09:18:40 INFO - { 09:18:40 INFO - "project": "", 09:18:40 INFO - "product": "firefox", 09:18:40 INFO - "script_repo_revision": "production", 09:18:40 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 09:18:40 INFO - "repository": "", 09:18:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 09:18:40 INFO - "buildid": "20160317072216", 09:18:40 INFO - "pgo_build": "False", 09:18:40 INFO - "basedir": "/builds/slave/test", 09:18:40 INFO - "buildnumber": 206, 09:18:40 INFO - "slavename": "t-yosemite-r7-0140", 09:18:40 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:18:40 INFO - "platform": "yosemite_r7", 09:18:40 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:18:40 INFO - "branch": "mozilla-aurora", 09:18:40 INFO - "repo_path": "releases/mozilla-aurora", 09:18:40 INFO - "revision": "5781664ff8a9a00fadb1349af3ae1487fdea94df", 09:18:40 INFO - "stage_platform": "macosx64", 09:18:40 INFO - "builduid": "234dfa4a45ec4b8ab7952061b1627dec", 09:18:40 INFO - "slavebuilddir": "test" 09:18:40 INFO - } 09:18:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 09:18:40 INFO - Running post-action listener: _resource_record_post_action 09:18:40 INFO - ##### 09:18:40 INFO - ##### Running download-and-extract step. 09:18:40 INFO - ##### 09:18:40 INFO - Running pre-action listener: _resource_record_pre_action 09:18:40 INFO - Running main action method: download_and_extract 09:18:40 INFO - mkdir: /builds/slave/test/build/tests 09:18: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')]} 09:18:40 INFO - https://queue.taskcluster.net/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:18:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 09:18:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 09:18:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 09:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 09:18:42 INFO - Downloaded 1277 bytes. 09:18:42 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 09:18:42 INFO - Using the following test package requirements: 09:18:42 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 09:18:42 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:18:42 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 09:18:42 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:18:42 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 09:18:42 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:18:42 INFO - u'jsshell-mac.zip'], 09:18:42 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:18:42 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 09:18:42 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 09:18:42 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:18:42 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 09:18:42 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:18:42 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 09:18:42 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:18:42 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 09:18:42 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 09:18:42 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:18:42 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 09:18:42 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:18: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')]} 09:18:42 INFO - https://queue.taskcluster.net/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:18:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:18:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:18:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:18:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:18:43 INFO - Downloaded 17867739 bytes. 09:18:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:18:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:18:46 INFO - Return code: 0 09:18:46 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:18:46 INFO - https://queue.taskcluster.net/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:18:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:18:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:18:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:18:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:18:47 INFO - Downloaded 17867739 bytes. 09:18:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:18:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:18:51 INFO - Return code: 0 09:18:51 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')]} 09:18:51 INFO - https://queue.taskcluster.net/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:18:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 09:18:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 09:18:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 09:18:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:18:52 INFO - Downloaded 10845161 bytes. 09:18:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:18:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:18:52 INFO - Return code: 0 09:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:18:52 INFO - https://queue.taskcluster.net/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 09:18:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:18:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:18:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 09:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 09:18:55 INFO - Downloaded 114974060 bytes. 09:18:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:18:55 INFO - mkdir: /builds/slave/test/properties 09:18:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:18:55 INFO - Writing to file /builds/slave/test/properties/build_url 09:18:55 INFO - Contents: 09:18:55 INFO - build_url:https://queue.taskcluster.net/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:18:56 INFO - Running post-action listener: _resource_record_post_action 09:18:56 INFO - Running post-action listener: set_extra_try_arguments 09:18:56 INFO - ##### 09:18:56 INFO - ##### Running populate-webroot step. 09:18:56 INFO - ##### 09:18:56 INFO - Running pre-action listener: _resource_record_pre_action 09:18:56 INFO - Running main action method: populate_webroot 09:18:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:18:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:18:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:18:56 INFO - '--tppagecycles', 09:18:56 INFO - '7'], 09:18:56 INFO - 'tests': ['tsvgm']}}, 09:18:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:18:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:18:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:18:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:18:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:18:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:18:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:56 INFO - 'talos_options': ['--e10s'], 09:18:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:56 INFO - 'tests': ['damp', 'tps']}, 09:18:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:56 INFO - 'talos_options': ['--e10s'], 09:18:56 INFO - 'tests': ['damp', 'tps']}, 09:18:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:18:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:18:56 INFO - 'other': {'tests': ['a11yr', 09:18:56 INFO - 'ts_paint', 09:18:56 INFO - 'tpaint', 09:18:56 INFO - 'sessionrestore', 09:18:56 INFO - 'sessionrestore_no_auto_restore', 09:18:56 INFO - 'tabpaint']}, 09:18:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:18:56 INFO - 'tests': ['a11yr', 09:18:56 INFO - 'ts_paint', 09:18:56 INFO - 'tpaint', 09:18:56 INFO - 'sessionrestore', 09:18:56 INFO - 'sessionrestore_no_auto_restore', 09:18:56 INFO - 'tabpaint']}, 09:18:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:18:56 INFO - 'tests': ['a11yr', 09:18:56 INFO - 'ts_paint', 09:18:56 INFO - 'tpaint', 09:18:56 INFO - 'sessionrestore', 09:18:56 INFO - 'sessionrestore_no_auto_restore', 09:18:56 INFO - 'tabpaint']}, 09:18:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:18:56 INFO - 'tests': ['a11yr', 09:18:56 INFO - 'ts_paint', 09:18:56 INFO - 'tpaint', 09:18:56 INFO - 'sessionrestore', 09:18:56 INFO - 'sessionrestore_no_auto_restore', 09:18:56 INFO - 'tabpaint']}, 09:18:56 INFO - 'other_l64': {'tests': ['a11yr', 09:18:56 INFO - 'ts_paint', 09:18:56 INFO - 'tpaint', 09:18:56 INFO - 'sessionrestore', 09:18:56 INFO - 'sessionrestore_no_auto_restore', 09:18:56 INFO - 'tabpaint']}, 09:18:56 INFO - 'other_nol64': {'tests': ['a11yr', 09:18:56 INFO - 'ts_paint', 09:18:56 INFO - 'tpaint', 09:18:56 INFO - 'sessionrestore', 09:18:56 INFO - 'sessionrestore_no_auto_restore', 09:18:56 INFO - 'tabpaint']}, 09:18:56 INFO - 'svgr': {'tests': ['tsvgx', 09:18:56 INFO - 'tsvgr_opacity', 09:18:56 INFO - 'tart', 09:18:56 INFO - 'tscrollx', 09:18:56 INFO - 'cart']}, 09:18:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:18:56 INFO - 'tests': ['tsvgx', 09:18:56 INFO - 'tsvgr_opacity', 09:18:56 INFO - 'tart', 09:18:56 INFO - 'tscrollx', 09:18:56 INFO - 'cart']}, 09:18:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:56 INFO - 'tests': ['tp5o']}, 09:18:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:56 INFO - 'talos_options': ['--e10s'], 09:18:56 INFO - 'tests': ['tp5o']}, 09:18:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:56 INFO - 'talos_options': ['--xperf_path', 09:18:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:56 INFO - 'tests': ['tp5n']}, 09:18:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:56 INFO - 'talos_options': ['--e10s', 09:18:56 INFO - '--xperf_path', 09:18:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:56 INFO - 'tests': ['tp5n']}}, 09:18:56 INFO - 'talos.zip': {'path': '', 09:18:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:18:56 INFO - Running post-action listener: _resource_record_post_action 09:18:56 INFO - ##### 09:18:56 INFO - ##### Running create-virtualenv step. 09:18:56 INFO - ##### 09:18:56 INFO - Running pre-action listener: _resource_record_pre_action 09:18:56 INFO - Running main action method: create_virtualenv 09:18:56 INFO - Creating virtualenv /builds/slave/test/build/venv 09:18:56 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 09:18:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:18:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:18:56 INFO - Using real prefix '/tools/python27' 09:18:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:18:57 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:00 INFO - Installing pip.................done. 09:19:00 INFO - Return code: 0 09:19:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102ec4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ecb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0f3c89060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d68d30>, '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 0x102bccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d5fb20>, '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.fR1lPDCOpf/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.WODF0XjIG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 09:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:19:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fR1lPDCOpf/Render', 09:19:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:00 INFO - 'HOME': '/Users/cltbld', 09:19:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:00 INFO - 'LOGNAME': 'cltbld', 09:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:00 INFO - 'MOZ_NO_REMOTE': '1', 09:19:00 INFO - 'NO_EM_RESTART': '1', 09:19:00 INFO - 'PAGER': '/bin/cat', 09:19:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:00 INFO - 'PWD': '/builds/slave/test', 09:19:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:00 INFO - 'SHELL': '/bin/bash', 09:19:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WODF0XjIG8/Listeners', 09:19:00 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:19:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:00 INFO - 'USER': 'cltbld', 09:19:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:00 INFO - 'XPC_FLAGS': '0x0', 09:19:00 INFO - 'XPC_SERVICE_NAME': '0', 09:19:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:00 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 09:19:00 INFO - Cleaning up... 09:19:00 INFO - Return code: 0 09:19:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102ec4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ecb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0f3c89060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d68d30>, '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 0x102bccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d5fb20>, '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.fR1lPDCOpf/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.WODF0XjIG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 09:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:19:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fR1lPDCOpf/Render', 09:19:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:00 INFO - 'HOME': '/Users/cltbld', 09:19:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:00 INFO - 'LOGNAME': 'cltbld', 09:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:00 INFO - 'MOZ_NO_REMOTE': '1', 09:19:00 INFO - 'NO_EM_RESTART': '1', 09:19:00 INFO - 'PAGER': '/bin/cat', 09:19:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:00 INFO - 'PWD': '/builds/slave/test', 09:19:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:00 INFO - 'SHELL': '/bin/bash', 09:19:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WODF0XjIG8/Listeners', 09:19:00 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:19:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:00 INFO - 'USER': 'cltbld', 09:19:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:00 INFO - 'XPC_FLAGS': '0x0', 09:19:00 INFO - 'XPC_SERVICE_NAME': '0', 09:19:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:00 INFO - Downloading/unpacking psutil>=0.7.1 09:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:03 INFO - Installing collected packages: psutil 09:19:03 INFO - Running setup.py install for psutil 09:19:03 INFO - building 'psutil._psutil_osx' extension 09:19:03 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 09:19:03 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 09:19:03 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 09:19:04 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 09:19:04 INFO - building 'psutil._psutil_posix' extension 09:19:04 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 09:19:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:19:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:19:04 INFO - ^ 09:19:04 INFO - 1 warning generated. 09:19:04 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 09:19:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:04 INFO - Successfully installed psutil 09:19:04 INFO - Cleaning up... 09:19:04 INFO - Return code: 0 09:19:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:19:04 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')]} 09:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:04 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')]} 09:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:04 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 0x102ec4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ecb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0f3c89060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d68d30>, '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 0x102bccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d5fb20>, '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.fR1lPDCOpf/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.WODF0XjIG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 09:19:04 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 09:19:04 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 09:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fR1lPDCOpf/Render', 09:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:04 INFO - 'HOME': '/Users/cltbld', 09:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:04 INFO - 'LOGNAME': 'cltbld', 09:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:04 INFO - 'MOZ_NO_REMOTE': '1', 09:19:04 INFO - 'NO_EM_RESTART': '1', 09:19:04 INFO - 'PAGER': '/bin/cat', 09:19:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:04 INFO - 'PWD': '/builds/slave/test', 09:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:04 INFO - 'SHELL': '/bin/bash', 09:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WODF0XjIG8/Listeners', 09:19:04 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:04 INFO - 'USER': 'cltbld', 09:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:04 INFO - 'XPC_FLAGS': '0x0', 09:19:04 INFO - 'XPC_SERVICE_NAME': '0', 09:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:19:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:19:07 INFO - Installing collected packages: mozsystemmonitor 09:19:07 INFO - Running setup.py install for mozsystemmonitor 09:19:07 INFO - Successfully installed mozsystemmonitor 09:19:07 INFO - Cleaning up... 09:19:07 INFO - Return code: 0 09:19:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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', '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 0x102ec4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ecb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0f3c89060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d68d30>, '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 0x102bccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d5fb20>, '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.fR1lPDCOpf/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.WODF0XjIG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 09:19: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:19: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 blobuploader==1.2.4 09:19:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fR1lPDCOpf/Render', 09:19:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:07 INFO - 'HOME': '/Users/cltbld', 09:19:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:07 INFO - 'LOGNAME': 'cltbld', 09:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:07 INFO - 'MOZ_NO_REMOTE': '1', 09:19:07 INFO - 'NO_EM_RESTART': '1', 09:19:07 INFO - 'PAGER': '/bin/cat', 09:19:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:07 INFO - 'PWD': '/builds/slave/test', 09:19:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:07 INFO - 'SHELL': '/bin/bash', 09:19:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WODF0XjIG8/Listeners', 09:19:07 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:19:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:07 INFO - 'USER': 'cltbld', 09:19:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:07 INFO - 'XPC_FLAGS': '0x0', 09:19:07 INFO - 'XPC_SERVICE_NAME': '0', 09:19:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:07 INFO - Downloading/unpacking blobuploader==1.2.4 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19:09 INFO - Downloading blobuploader-1.2.4.tar.gz 09:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:19:09 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 09:19:09 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 09:19:09 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 09:19:09 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 09:19:09 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 09:19:09 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 09:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:19:10 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 09:19:10 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 09:19:10 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 09:19:10 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 09:19:10 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 09:19:10 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 09:19:11 INFO - Downloading docopt-0.6.1.tar.gz 09:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:11 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:11 INFO - Running setup.py install for blobuploader 09:19:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:11 INFO - Running setup.py install for requests 09:19:11 INFO - Running setup.py install for docopt 09:19:11 INFO - Successfully installed blobuploader requests docopt 09:19:11 INFO - Cleaning up... 09:19:12 INFO - Return code: 0 09:19:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:12 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')]} 09:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:12 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')]} 09:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:12 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 0x102ec4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ecb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0f3c89060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d68d30>, '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 0x102bccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d5fb20>, '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.fR1lPDCOpf/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.WODF0XjIG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 09:19:12 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 09:19:12 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 09:19:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fR1lPDCOpf/Render', 09:19:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:12 INFO - 'HOME': '/Users/cltbld', 09:19:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:12 INFO - 'LOGNAME': 'cltbld', 09:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:12 INFO - 'MOZ_NO_REMOTE': '1', 09:19:12 INFO - 'NO_EM_RESTART': '1', 09:19:12 INFO - 'PAGER': '/bin/cat', 09:19:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:12 INFO - 'PWD': '/builds/slave/test', 09:19:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:12 INFO - 'SHELL': '/bin/bash', 09:19:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WODF0XjIG8/Listeners', 09:19:12 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:19:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:12 INFO - 'USER': 'cltbld', 09:19:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:12 INFO - 'XPC_FLAGS': '0x0', 09:19:12 INFO - 'XPC_SERVICE_NAME': '0', 09:19:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:12 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-bHCHuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:12 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-CuSrEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:12 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-pgGlwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:12 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-eYHgUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:12 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-xRZl6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:12 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Npn38A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:12 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-jHhmAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:13 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-1nHqX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:13 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Hl4RYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:13 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Aw1eTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:13 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-DFBMv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:13 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-h3yQSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:13 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-6ryA5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:13 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-15widL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:13 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-PHen51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:13 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Q53OpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:13 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-9Cv2Iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:14 INFO - Running setup.py install for manifestparser 09:19:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:14 INFO - Running setup.py install for mozcrash 09:19:14 INFO - Running setup.py install for mozdebug 09:19:14 INFO - Running setup.py install for mozdevice 09:19:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:19:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:19:14 INFO - Running setup.py install for mozfile 09:19:14 INFO - Running setup.py install for mozhttpd 09:19:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:19:14 INFO - Running setup.py install for mozinfo 09:19:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:15 INFO - Running setup.py install for mozInstall 09:19:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:15 INFO - Running setup.py install for mozleak 09:19:15 INFO - Running setup.py install for mozlog 09:19:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:15 INFO - Running setup.py install for moznetwork 09:19:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:15 INFO - Running setup.py install for mozprocess 09:19:15 INFO - Running setup.py install for mozprofile 09:19:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:16 INFO - Running setup.py install for mozrunner 09:19:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:16 INFO - Running setup.py install for mozscreenshot 09:19:16 INFO - Running setup.py install for moztest 09:19:16 INFO - Running setup.py install for mozversion 09:19:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:16 INFO - Cleaning up... 09:19:16 INFO - Return code: 0 09:19:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x102ec4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ecb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0f3c89060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d68d30>, '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 0x102bccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d5fb20>, '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.fR1lPDCOpf/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.WODF0XjIG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 09:19:16 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 09:19:16 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 09:19:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fR1lPDCOpf/Render', 09:19:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:16 INFO - 'HOME': '/Users/cltbld', 09:19:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:16 INFO - 'LOGNAME': 'cltbld', 09:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:16 INFO - 'MOZ_NO_REMOTE': '1', 09:19:16 INFO - 'NO_EM_RESTART': '1', 09:19:16 INFO - 'PAGER': '/bin/cat', 09:19:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:16 INFO - 'PWD': '/builds/slave/test', 09:19:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:16 INFO - 'SHELL': '/bin/bash', 09:19:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WODF0XjIG8/Listeners', 09:19:16 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:19:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:16 INFO - 'USER': 'cltbld', 09:19:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:16 INFO - 'XPC_FLAGS': '0x0', 09:19:16 INFO - 'XPC_SERVICE_NAME': '0', 09:19:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:16 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-HcmgjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:17 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)) 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:17 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-ZXVoYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:17 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)) 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:17 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-FVhsem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:17 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)) 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:17 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-DLA1A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:17 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)) 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:17 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Ji2Nmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:17 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)) 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:17 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-7zUgCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:17 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)) 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:17 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-ndQqC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:17 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)) 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:17 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-fIXx0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:17 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)) 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:17 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-NFTqlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:17 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)) 09:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:17 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-MPfqpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:18 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)) 09:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-8sXCqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:18 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)) 09:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-hKjDGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:18 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)) 09:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-g9I2sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:18 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)) 09:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Ecs34p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:18 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)) 09:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-_ry6Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:18 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)) 09:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-RZZ7v3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:18 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)) 09:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-A9fosr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:18 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)) 09:19:18 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)) 09:19:18 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)) 09:19:18 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)) 09:19:18 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)) 09:19:18 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)) 09:19:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:18 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 09:19:18 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 09:19:18 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 09:19:18 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 09:19:18 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 09:19:18 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 09:19:21 INFO - Downloading blessings-1.6.tar.gz 09:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:21 INFO - Installing collected packages: blessings 09:19:21 INFO - Running setup.py install for blessings 09:19:21 INFO - Successfully installed blessings 09:19:21 INFO - Cleaning up... 09:19:21 INFO - Return code: 0 09:19:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:21 INFO - Reading from file tmpfile_stdout 09:19:21 INFO - Current package versions: 09:19:21 INFO - blessings == 1.6 09:19:21 INFO - blobuploader == 1.2.4 09:19:21 INFO - docopt == 0.6.1 09:19:21 INFO - manifestparser == 1.1 09:19:21 INFO - mozInstall == 1.12 09:19:21 INFO - mozcrash == 0.17 09:19:21 INFO - mozdebug == 0.1 09:19:21 INFO - mozdevice == 0.48 09:19:21 INFO - mozfile == 1.2 09:19:21 INFO - mozhttpd == 0.7 09:19:21 INFO - mozinfo == 0.9 09:19:21 INFO - mozleak == 0.1 09:19:21 INFO - mozlog == 3.1 09:19:21 INFO - moznetwork == 0.27 09:19:21 INFO - mozprocess == 0.22 09:19:21 INFO - mozprofile == 0.28 09:19:21 INFO - mozrunner == 6.11 09:19:21 INFO - mozscreenshot == 0.1 09:19:21 INFO - mozsystemmonitor == 0.0 09:19:21 INFO - moztest == 0.7 09:19:21 INFO - mozversion == 1.4 09:19:21 INFO - psutil == 3.1.1 09:19:21 INFO - requests == 1.2.3 09:19:21 INFO - wsgiref == 0.1.2 09:19:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:21 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')]} 09:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:21 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')]} 09:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:21 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 0x102ec4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ecb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0f3c89060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d68d30>, '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 0x102bccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d5fb20>, '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.fR1lPDCOpf/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.WODF0XjIG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 09:19:21 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 09:19:21 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 09:19:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fR1lPDCOpf/Render', 09:19:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:21 INFO - 'HOME': '/Users/cltbld', 09:19:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:21 INFO - 'LOGNAME': 'cltbld', 09:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:21 INFO - 'MOZ_NO_REMOTE': '1', 09:19:21 INFO - 'NO_EM_RESTART': '1', 09:19:21 INFO - 'PAGER': '/bin/cat', 09:19:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:21 INFO - 'PWD': '/builds/slave/test', 09:19:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:21 INFO - 'SHELL': '/bin/bash', 09:19:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WODF0XjIG8/Listeners', 09:19:21 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:19:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:21 INFO - 'USER': 'cltbld', 09:19:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:21 INFO - 'XPC_FLAGS': '0x0', 09:19:21 INFO - 'XPC_SERVICE_NAME': '0', 09:19:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:21 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)) 09:19:21 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)) 09:19:21 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)) 09:19:21 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)) 09:19:21 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)) 09:19:21 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)) 09:19:21 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)) 09:19:21 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)) 09:19:21 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)) 09:19:21 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)) 09:19:21 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)) 09:19:21 INFO - Cleaning up... 09:19:21 INFO - Return code: 0 09:19:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:19:21 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')]} 09:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:21 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')]} 09:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:21 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 0x102ec4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ecb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0f3c89060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d68d30>, '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 0x102bccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d5fb20>, '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.fR1lPDCOpf/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.WODF0XjIG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 09:19:21 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 09:19:21 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 09:19:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fR1lPDCOpf/Render', 09:19:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:21 INFO - 'HOME': '/Users/cltbld', 09:19:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:21 INFO - 'LOGNAME': 'cltbld', 09:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:21 INFO - 'MOZ_NO_REMOTE': '1', 09:19:21 INFO - 'NO_EM_RESTART': '1', 09:19:21 INFO - 'PAGER': '/bin/cat', 09:19:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:21 INFO - 'PWD': '/builds/slave/test', 09:19:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:21 INFO - 'SHELL': '/bin/bash', 09:19:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WODF0XjIG8/Listeners', 09:19:21 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:19:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:21 INFO - 'USER': 'cltbld', 09:19:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:21 INFO - 'XPC_FLAGS': '0x0', 09:19:21 INFO - 'XPC_SERVICE_NAME': '0', 09:19:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:22 INFO - Downloading/unpacking jsonschema 09:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:24 INFO - Downloading/unpacking functools32 (from jsonschema) 09:19:24 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 09:19:24 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 09:19:24 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 09:19:24 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 09:19:24 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 09:19:24 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 09:19:24 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:24 INFO - warning: no files found matching '*.txt' 09:19:24 INFO - no previously-included directories found matching 'build' 09:19:24 INFO - no previously-included directories found matching 'dist' 09:19:24 INFO - no previously-included directories found matching '.git*' 09:19:24 INFO - Installing collected packages: jsonschema, functools32 09:19:25 INFO - Running setup.py install for functools32 09:19:25 INFO - warning: no files found matching '*.txt' 09:19:25 INFO - no previously-included directories found matching 'build' 09:19:25 INFO - no previously-included directories found matching 'dist' 09:19:25 INFO - no previously-included directories found matching '.git*' 09:19:25 INFO - Successfully installed jsonschema functools32 09:19:25 INFO - Cleaning up... 09:19:25 INFO - Return code: 0 09:19:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:25 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 0x102ec4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ecb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0f3c89060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d68d30>, '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 0x102bccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d5fb20>, '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.fR1lPDCOpf/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.WODF0XjIG8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 09:19:25 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 09:19:25 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 09:19:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fR1lPDCOpf/Render', 09:19:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:25 INFO - 'HOME': '/Users/cltbld', 09:19:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:25 INFO - 'LOGNAME': 'cltbld', 09:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:25 INFO - 'MOZ_NO_REMOTE': '1', 09:19:25 INFO - 'NO_EM_RESTART': '1', 09:19:25 INFO - 'PAGER': '/bin/cat', 09:19:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:25 INFO - 'PWD': '/builds/slave/test', 09:19:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:25 INFO - 'SHELL': '/bin/bash', 09:19:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WODF0XjIG8/Listeners', 09:19:25 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:19:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:25 INFO - 'USER': 'cltbld', 09:19:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:25 INFO - 'XPC_FLAGS': '0x0', 09:19:25 INFO - 'XPC_SERVICE_NAME': '0', 09:19:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:25 INFO - Downloading/unpacking flake8 09:19:25 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 09:19:25 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 09:19:25 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 09:19:25 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 09:19:25 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 09:19:25 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 09:19:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:19:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:19:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:19:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:19:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:19:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:19:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:19:29 INFO - no previously-included directories found matching 'docs/_build' 09:19:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:19:30 INFO - Running setup.py install for pep8 09:19:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:19:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:19:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:19:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:19:30 INFO - no previously-included directories found matching 'docs/_build' 09:19:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:19:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:19:30 INFO - Cleaning up... 09:19:30 INFO - Return code: 0 09:19:30 INFO - Running post-action listener: _resource_record_post_action 09:19:30 INFO - Running post-action listener: _start_resource_monitoring 09:19:30 INFO - Starting resource monitoring. 09:19:30 INFO - ##### 09:19:30 INFO - ##### Running install step. 09:19:30 INFO - ##### 09:19:30 INFO - Running pre-action listener: _resource_record_pre_action 09:19:30 INFO - Running main action method: install 09:19:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:30 INFO - Reading from file tmpfile_stdout 09:19:30 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:30 INFO - Reading from file tmpfile_stdout 09:19:30 INFO - Output received: 09:19:30 INFO - Usage: mozinstall [options] installer 09:19:30 INFO - Options: 09:19:30 INFO - -h, --help show this help message and exit 09:19:30 INFO - -d DEST, --destination=DEST 09:19:30 INFO - Directory to install application into. [default: 09:19:30 INFO - "/builds/slave/test"] 09:19:30 INFO - --app=APP Application being installed. [default: firefox] 09:19:30 INFO - mkdir: /builds/slave/test/build/application 09:19:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:20:02 INFO - Reading from file tmpfile_stdout 09:20:02 INFO - Output received: 09:20:02 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:20:02 INFO - Running post-action listener: _resource_record_post_action 09:20:02 INFO - ##### 09:20:02 INFO - ##### Running run-tests step. 09:20:02 INFO - ##### 09:20:02 INFO - Running pre-action listener: _resource_record_pre_action 09:20:02 INFO - Running main action method: run_tests 09:20:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:20:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:20:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:20:02 INFO - 2016-03-17 09:20:02.753 screenresolution[2566:38013] starting screenresolution argv=screenresolution get 09:20:02 INFO - 2016-03-17 09:20:02.756 screenresolution[2566:38013] Display 0: 1600x1200x32@60 09:20:02 INFO - 2016-03-17 09:20:02.762 screenresolution[2567:38016] starting screenresolution argv=screenresolution list 09:20:02 INFO - Available Modes on Display 0 09:20:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:20:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:20:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:20:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:20:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:20:02 INFO - Intel Iris: 09:20:02 INFO - Chipset Model: Intel Iris 09:20:02 INFO - Type: GPU 09:20:02 INFO - Bus: Built-In 09:20:02 INFO - VRAM (Dynamic, Max): 1536 MB 09:20:02 INFO - Vendor: Intel (0x8086) 09:20:02 INFO - Device ID: 0x0a2e 09:20:02 INFO - Revision ID: 0x0009 09:20:02 INFO - Displays: 09:20:02 INFO - Display: 09:20:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:20:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:20:02 INFO - Display Serial Number: 1600x1200 60 09:20:02 INFO - Main Display: Yes 09:20:02 INFO - Mirror: Off 09:20:02 INFO - Online: Yes 09:20:02 INFO - Rotation: Supported 09:20:03 INFO - Return code: 0 09:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:20:03 INFO - Python 2.7.3 09:20:03 INFO - Return code: 0 09:20:03 INFO - grabbing minidump binary from tooltool 09:20: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')]} 09:20:03 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 0x102d68d30>, '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 0x102bccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d5fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:20:03 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 09:20:03 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 09:20:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:20:03 INFO - Return code: 0 09:20:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:20:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:20:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:20:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:20:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:20:04 INFO - Return code: 0 09:20:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--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 09:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0140 --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 09:20:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fR1lPDCOpf/Render', 09:20:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:04 INFO - 'HOME': '/Users/cltbld', 09:20:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:04 INFO - 'LOGNAME': 'cltbld', 09:20:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:04 INFO - 'MOZ_NO_REMOTE': '1', 09:20:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:04 INFO - 'NO_EM_RESTART': '1', 09:20:04 INFO - 'PAGER': '/bin/cat', 09:20:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:04 INFO - 'PWD': '/builds/slave/test', 09:20:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:04 INFO - 'SHELL': '/bin/bash', 09:20:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WODF0XjIG8/Listeners', 09:20:04 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:20:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:04 INFO - 'USER': 'cltbld', 09:20:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:04 INFO - 'XPC_FLAGS': '0x0', 09:20:04 INFO - 'XPC_SERVICE_NAME': '0', 09:20:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--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 09:20:04 INFO - mozversion application_buildid: 20160317072216 09:20:04 INFO - mozversion application_changeset: 5781664ff8a9a00fadb1349af3ae1487fdea94df 09:20:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:20:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:20:04 INFO - mozversion application_name: Firefox 09:20:04 INFO - mozversion application_remotingname: firefox-dev 09:20:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:20:04 INFO - mozversion application_vendor: Mozilla 09:20:04 INFO - mozversion application_version: 47.0a2 09:20:04 INFO - mozversion platform_buildid: 20160317072216 09:20:04 INFO - mozversion platform_changeset: 5781664ff8a9a00fadb1349af3ae1487fdea94df 09:20:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:20:04 INFO - mozversion platform_version: 47.0a2 09:20:04 INFO - using testdate: 1458231604 09:20:04 INFO - actual date: 1458231604 09:20:04 INFO - starting webserver on 'localhost:51885' 09:20:04 INFO - SUITE-START | Running 2 tests 09:20:04 INFO - TEST-START | dromaeo_css 09:20:04 INFO - operating with platform_type : mac_ 09:20:04 INFO - Initialising browser for dromaeo_css test... 09:20:04 INFO - TEST-INFO | started process 2585 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpAwIAwA/profile http://localhost:51885/getInfo.html) 09:20:07 INFO - PROCESS | 2585 | __metrics Screen width/height:1600/1200 09:20:07 INFO - PROCESS | 2585 | colorDepth:24 09:20:07 INFO - PROCESS | 2585 | Browser inner width/height: 1024/689 09:20:07 INFO - PROCESS | 2585 | __metrics 09:20:07 ERROR - PROCESS | 2585 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:20:08 INFO - TEST-INFO | 2585: exit 0 09:20:08 INFO - Browser initialized. 09:20:08 INFO - Running cycle 1/1 for dromaeo_css test... 09:20:08 INFO - TEST-INFO | started process 2588 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpAwIAwA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:19 INFO - PROCESS | 2588 | RSS: Main: 219787264 09:20:19 INFO - PROCESS | 2588 | 09:21:09 INFO - PROCESS | 2588 | 1458231669628 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] 09:23:21 INFO - PROCESS | 2588 | Cycle 1(1): loaded http://localhost:51885/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51885/tests/dromaeo/cssquery-ext.html) 09:23:22 INFO - PROCESS | 2588 | RSS: Main: 236666880 09:23:22 INFO - PROCESS | 2588 | 09:26:24 INFO - PROCESS | 2588 | Cycle 1(1): loaded http://localhost:51885/tests/dromaeo/cssquery-ext.html (next: http://localhost:51885/tests/dromaeo/cssquery-jquery.html) 09:26:25 INFO - PROCESS | 2588 | RSS: Main: 247377920 09:26:25 INFO - PROCESS | 2588 | 09:29:27 INFO - PROCESS | 2588 | Cycle 1(1): loaded http://localhost:51885/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51885/tests/dromaeo/cssquery-mootools.html) 09:29:27 INFO - PROCESS | 2588 | RSS: Main: 249536512 09:29:27 INFO - PROCESS | 2588 | 09:32:29 INFO - PROCESS | 2588 | Cycle 1(1): loaded http://localhost:51885/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51885/tests/dromaeo/cssquery-prototype.html) 09:32:30 INFO - PROCESS | 2588 | RSS: Main: 250503168 09:32:30 INFO - PROCESS | 2588 | 09:35:32 INFO - PROCESS | 2588 | Cycle 1(1): loaded http://localhost:51885/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51885/tests/dromaeo/cssquery-yui.html) 09:35:33 INFO - PROCESS | 2588 | RSS: Main: 254578688 09:35:33 INFO - PROCESS | 2588 | 09:38:35 INFO - PROCESS | 2588 | Cycle 1(1): loaded http://localhost:51885/tests/dromaeo/cssquery-yui.html (next: http://localhost:51885/tests/dromaeo/cssquery-dojo.html) 09:38:35 INFO - PROCESS | 2588 | RSS: Main: 255827968 09:38:35 INFO - PROCESS | 2588 | 09:38:35 INFO - PROCESS | 2588 | __start_tp_report 09:38:35 INFO - PROCESS | 2588 | _x_x_mozilla_page_load 09:38:35 INFO - PROCESS | 2588 | _x_x_mozilla_page_load_details 09:38:35 INFO - PROCESS | 2588 | |i|pagename|runs| 09:38:35 INFO - PROCESS | 2588 | |0;dojo.html;3101.5502752100947;3525.7003154731838;3550.91697032405;3560.8041557714314;3619.60184379718;5926.851828704284;5946.494547963428;5949.286085669715;5966.850828729284;5968.9701551492235;5945.108233764938;5957.821265362035;5979.551533634973;6019.307779605347;6043.305019922699;5327.121025030875;5350.30446042016;5405.837824865261;5426;5474.808381706641;5267.1309233976535;5376.489233522809;5385.165299378583;5408.648437851547;5415.458454154573;5376.301080859483;5398.595105367093;5405.756740946647;5409.377921539034;5410.3507579090565;5326.493983071602;5364.839054828361;5417.674939503623;5438.864028399282;5442.965836491054;5305.4164041955355;5370.22131790892;5371.086915224421;5385.2999110115825;5411.377691565481;5557.833265002016;5673.716314184274;5710.7430165642645;5925.31858836235;6067.211262535886;6240.687965601702;6249.218847644044;6255.843603909893;6256.937430625681;6288.685565721696;6335.778247761353;6341.8414539636415;6345.07996340528;6356.618602883842;6358;5978.790742323998;6044.274687037496;6057.575969682124;6090.695465226721;6110.862540392742;6469.126667899867;6473.2232132144445;6493.383128602775;6512.251091124582;6590;6238.65687387189;6253.624782513064;6259.7496100156395;6262.718177682015;6304.71628776697;6199.256089269316;6279.560430769893;6279.623222606659;6335.619862808247;6342.302346741854;6192.659403732748;6226.62640241587;6263.749450021948;6265.937340626535;6388.4569811566535;6121.540884433685;6207.193064901534;6259.968700156561;6281.183446151971;6291.7797877075;5000.1749711297225;5032.647714659939;5043.747812609355;5049.267856160836;5088.643794934393;4473.015936493966;4483.103379324149;4525.094981003813;4535.365048893158;4541.069080838421;5757.337906140848;5839.124131380327;5972.984592619265;5980.820575382745;6003.129546215774;6224.37756224383;6241;6249.375062493714;6339.651319177489;6345.587536810092;5960.493358064527;5999.430054144849;6004.609700369462;6014.127951447016;6049.364816694272;5414;5543.334799824047;5551.3893471718075;5567.053600887778;5569.944300556943;5524.4199359066715;6458.806235812933;6550.737970481127;6581.736730530725;6582.539222254588;6274.309825919237;6303.779367722291;6307.716152773228;6314.842128946813;6315.810525684236;6311.305756366704;6499.155109835691;6510.544261901811;6586.407223349922;6593.307702691149;6184.165137706532;6262.185915830913;6265.592736472115;6277.748890044347;6287.1512345832725;6288.811335659938;6301.684915754286;6309.621422714652;6310.6844657766005;6313.621182729051;6143.051335358963;6153.661548614869;6211.254649442096;6248.0940263660605;6262.4990000800735;6220.284667263322;6226.40849119333;6229.408206220402;6238.656873871981;6256.843578910563;6097.237845269341;6141.385861414002;6228.719707613078;6238.469730072813;6248.218972628421;5371.355437347544;6111.561351782648;6145.863015342176;6151.569390142647;6166.81499555014;5248.816291429782;5613.803516876889;5834.416558344132;6141.823559979257;6252.187215661935 09:38:35 INFO - PROCESS | 2588 | |1;ext.html;571.5313442976758;598.7634884220732;608.7199888051496;656.7504348347627;675.0751470485436;30389.240268993257;38608.613913860856;38705.612943870554;38772.224555508874;39099.60900390995;40368.39447408291;40600.59399406005;40884.79557602208;40896.591034089724;40975;9458.196053335458;9603.18372938301;9644.276679249084;9645.614175432975;9680.273979451535;9495.81008379832;9710.223182145412;9767.658131965383;9795.853062204073;9822.312438129335;9826.950865245664;9828.361156524803;9836.852447213298;9842.655507057254;9852.26108041896;9758.121769040785;9814.411135331831;9828.508574571242;9840.376337904238;9857.063578959987;9664.468454235015;9757.756056098584;9772.267079969031;9781.266405019582;9784.55969481375;33767.493487597705;34120.48819267713;40392.39411408831;40573.39139912904;40775.59224407777;3096.4426403247408;3112.564241006261;3232.402005628966;3297.884574039897;3407.30150319184;27393;27436.03973860925;27522.724772752215;27808.02671906494;29635.962741304167;2663.613776002488;2768.183385901144;2778.458200650874;2797.8181418207955;2845.1891211004972;310877;313676.43161784275;313918.4304078488;314137;314171.85828141886;48273.27590086152;48732.7563362188;69343.65328173428;69613;69836;46321;46569;46603.766981164874;46676;46751.5324846754;14078.788818167735;16367.099809510592;16823.327066917187;16879.578010549834;16947;13613.97895157867;13693.246871422167;13723.862761372258;13736.93131534356;13743.244121573409;13021.153625014344;14526.20105894186;14891.553253402415;15004.62488437776;15019.624509387353;6462.547621666438;6620.205575330991;6640.634765087966;6647.501437392215;6655.267920528738;991.6033586565287;1049.150188347441;1093.9507722152364;1105.4638500327335;1202.9518819247307;28896.277593060342;29049.27376815554;29598.112056638336;30406.391872162876;30918.845405773278;989.9505024748734;1097.3635291530893;1137.4995002199005;1139.2708666453477;1293.7818046419263;15332.693346133015;15642.921785391229;15759.842401575837;15786.842131578767;15990.840091599168;554355;563085;563422.1828890911;564568;565089;62558;63279;63736.68131659312;63772.68113659402;63819.36180638134;1507.2539093148741;1537.48494254426;1543.4135028689027;1545.8299587045642;1553.4407613259218;21860.672089918982;29117;30008.84995575008;30409.39181216319;30990.845045775528;54470;54476;54804.45195547993;54818.90362192813;54848;378042;445816;446987;447424;447778;30065.69934300629;33144.33711325808;34956.30087398289;35565;35622.28755424825;46454;47171.292430612884;47694.04611907673;47830.760846195546;48230.5176948226;38195;38321;39337.01657458472;39356.212875742895;39440;37359.87920362393;37662.81168594139;37828.43257351087;38128.23743525169;38208.42687359636;32896.51965661503;37260.06849828776;38119.80940095393;38435.03912402212;38903.02742431462;29992;31115.837176021912;31140.22149446282;31151;31220.219494512818;25089.12188073409;25286;25316;25571.488570228863;25651.743482564936 09:38:35 INFO - PROCESS | 2588 | |2;jquery.html;344.6105900332624;371.70449492653336;385.0931057359918;385.16419369967184;387.80609695152424;20207.898960505194;21044;21466.570668586657;22181.556368872614;22220.777792222074;21311.893440532775;21447.249346272885;21672;21741.021654025568;21843.890780546077;4455.042165934332;5652.773889044433;5674.631148975303;5907.704614769265;5910.202122713443;5660;5756.395578464264;5772.942270577303;5780.682062486561;5801.883962320751;5639.8590035249035;5643.322801263854;5728.083506638938;5728.25532680753;5732.79935202268;5644.322681278232;5732.22614946981;5751.568632352549;5799.18811366409;5828.1257811328005;5071.543561079484;5079.619028572835;5086.618503612207;5111.207762796773;5117.872053198663;18247.54381140469;23251.302460926032;24226.152084677127;24949.62575561368;25336.733163341945;2130.38218916514;2139.962118372588;2147.95704085919;2238.4068221921043;2257.600287821545;10203.540840662188;10322.277440579162;12858.292793896331;14060.296985150702;14484.565463036126;1801.8108098649584;1835.7613510243716;1838.6138910828743;1855.5361159710073;1856.1740025688573;96803.0319696801;116596.41701791521;117240;119793.40103299514;120046.3997680006;9617.471039092778;9833.508324583741;11955.88044119565;12036.81944770829;12086.576969806014;12156.149069565046;14299.428022879176;14439.35022923971;14467.27663616815;14497.275136243357;7516.849663006709;8221.753347399588;8458.154184581615;9005.819883602422;9290.581923813445;7816.53100813953;9219.032001639865;9224.30817688676;9249.491277979641;9320.114589114024;4586.770661466913;4660.114578230193;4665.043666048452;4702.200625893606;4707.599854012379;1653.148628456346;1967.1147983407525;1975.3580086471954;1980.8910509922093;2019.636745196986;921.635953798246;943.6366998705548;966.0484422843493;980.4999450280266;1013.366645846346;17082.743758843626;18384.81615183858;19426;19954.800451995583;20106.82185064854;981.254246772458;984.4044353166374;1022.0648106982177;1028.6708253359002;1035.3322107240788;10856.72858178536;11074.612388566522;11083.224174307721;11086.501107450184;11353.886461135447;680502.5974870094;689112;697698;704250.478747603;710024;123071.15393269109;125809;125953;127819;128004;897.8877640294963;976.4629453800381;992.6575331510618;993.4287784523783;1000.1498726082772;16106.597335066717;18297.90212587249;18372.632547349247;18385.632287354445;18567.81432185715;51879.740601296755;52215.21677174921;53661.19508207302;54141.64645883884;56754.432455676564;80574.79137813055;81479.18520814716;82226;84737.57631211805;89993.10006900108;11136.777264454828;11258.155638327322;11964.521419143137;12167.39163041862;12570.308633024906;11903.631082425285;13375.799363009368;14038.1577105374;14143.222122783345;14388.85611143917;11883.405829708307;11892.940535297268;12125.818112728493;12180.817287740514;12227.205231659913;11736.70658233551;11921.940390297994;11946.522139114339;11949.880501194877;12035.879641203475;5979.730912109053;12080.275183489019;12135.878641213474;12165.513379465076;12213.69465763363;11765.11761617865;12139.210951288138;12177.391130443266;12280.877191227974;12386.81419778686;12110.091743119478;12122.575709850113;12156.149069565046;12277.815832762695;12331.44508497102 09:38:35 INFO - PROCESS | 2588 | |3;mootools.html;1673.9079350635714;1690.180262572652;1777.3334999375227;1906.3994841624879;2092.811646951774;8412.074671786115;9090.681826136086;9209.171174594285;9423;9455.00722424145;9282.907170928289;9307.72076837696;9372.671956481507;9391.154796068353;9396.577154028068;2604.661394018775;2611.5690910999756;2619.882105305256;2627.6452678888295;2632.4340266842623;2543;2585.7802086822644;2590.520753660579;2592.092767531368;2594.2736033910537;2370.1230544698487;2557.475717477922;2590.844549327037;2608.191460647196;2614.0066774625616;2460.753924607534;2563.628273900274;2587.4178309880126;2590.2617753940226;2596.8961241550314;2235.564065007324;2565.961510577343;2595.4679290745353;2596.7143614202423;2617.751313625203;9477.28920330971;9494.95252523733;9533.142017218484;9553.474558899257;9562.713118606453;5710.714464276811;5913.113033045035;5929.555283353722;5931.673757943311;5968.045112781934;3635.781853088823;3700.4079347304573;3767.2842159989514;3799.639034291738;3847.615238476158;1044.843273508972;1059.8940105989338;1060.7242117049545;1082.6697857153565;1104.7403860092872;11320.547178112865;12219.511219551207;12577.685557861036;12648.936755316257;12750.362481875869;5110.463401342806;5134.486551344836;5228.607854410859;5234.18870075139;5244.501772331622;10840.566377344818;10861.511231994578;10868.402237876993;10871.891281087246;10890.401027943539;5655.632383895034;5761.740721667535;5774.769009239667;5861.824145275648;5879.147523609053;4677.4854765975715;5061.215511595708;5112.71880046601;5199.610029247821;5200.323957885526;4127.09203975125;4195.895102622459;4199.0552125772065;4207.600277973587;4209.284421648327;1179.55177032727;1369.5069774881035;1385.0789225165354;1396;1405.3184205660248;1387.9722405552034;1455.4542046732474;1461.875740562064;1482.4440834686993;1485.094092603511;8637.481751094954;8690.652373904974;8723.171298726611;8738.606762695694;8742.082081381363;517.4385791416355;527.5489456514701;534.1640332879032;534.5750128647734;535.1865164949334;6432.517561182836;6451.903221451682;6500.837479063061;6501.674916254168;6511.283758786624;11244;11561;11622.07023438123;11655.009324207367;11718.23831450953;11245.212835101627;11260.380679062566;11408.258463199865;11503.539858405737;11511.19421640477;8763.518006509576;8880.37837351392;8943.37396382247;8959.148880856308;8983.416077954913;8161.143079976517;8326.583670816555;8329.541875196923;8369.874451883104;8381.413301068867;10123.696289111338;10200.744981375525;10205.489725513546;10343.27597068198;10349.27555071168;10349.120324772479;10372.066514013775;10648.733781655521;10648.84026739584;10679.946600266949;6691.297413771484;7112.537685050662;7573.431992600687;7740.187280335484;7928.445008849325;8715.38992270535;8732.738017859474;8771.298296136421;8835.160659737314;8837;7639.427042971688;7907.802304942423;7936.246056624612;7968.521888686466;7971.561564114029;7644.273793989562;7699.576523291273;7717.498362606412;7789.649465774167;7807.804804879696;8176.509409435453;8240.752777416687;8287.046989596032;8290.170982901662;8297.875531866906;7358.66885990121;7361.079865016873;7369.078865141857;7455.0681164854395;7470.3276705096805;7442.553446793209;7450.552966822008;7512.511686740344;7537.924620753723;7543.35881450061 09:38:35 INFO - PROCESS | 2588 | |4;prototype.html;309.91942095055276;314.3194982862104;328.2008309765719;347.71661096206606;348.7959543666954;7013.228544860061;7046.5067445278855;7050.85898282034;7060.293970602937;7100.928990710091;6949.826254343644;6961.373476387124;7040.119985001875;7056.858862822741;7072.66602021333;4903.632227582928;4972.825951091712;5088.084144853925;5099.592032637399;5102.489751024905;5059.6458247922665;5112.284280200774;5115.10485665009;5159.936025589775;5168.224766285069;5109.284700141983;5114.207297868837;5116.1302578561545;5117.232415137741;5130.743462826862;5124.92312615311;5128.205128205134;5129.692218466904;5134.204198349262;5136.9743151284;4393.989382442024;4399.472063352418;4404.889877753049;4413.845515406977;4420.226460369422;6668.93331066688;6676.766313179064;6752.93247067528;6782.118324617817;6838.111045564045;6020.759169633209;6071.908921366183;6074.817755467343;6075.756969721206;6075.939240607581;7503.849923001564;7517.5113617615225;7535.547867127935;7537.397008239328;7574.734884279023;4111;4947.876303092416;4950.9009819803405;4951.207806750938;4957.628177886673;7149.49953503255;7849.175836537195;7959.641816118288;7997.520148791033;8003.079645840745;4908.558229759267;4972.527609877128;4980.327655766425;4990.600751939836;4990.975045124751;5069.188929771219;5097.260897169889;5098.209777484496;5101.362329708786;5107.259447380109;5314.937012597496;5639.351474580476;5983.461488466059;5993.580449368589;6006.339302676702;6168.938310616926;7543.170251272356;7560.546367217985;7603.581803000888;7607.125180604191;1683.9242234099495;1712.623222890962;1741.9390321338947;1779.128227168678;1783.028249603969;1159.704275409782;1164.8369228308043;1167.5913430299327;1170.7424366639325;1180.0972256223995;6928.16861976566;6935.549189302679;6961.095057642474;6979.89530157048;6997.93002069983;6377.489800815923;7803.492772969739;7811.257930496708;7819.960900195462;7841.921580784233;6031.24609423822;6625.3374662534325;6934.613077384543;6970.651467426608;6986.371226589631;3956.8615098471414;4100.91798164035;4125.587441255911;4131.855385061569;4134.214499245134;8118.594070296462;8140.3487720982175;8172.6730930762105;8182.22268884455;8186.918130818615;6175.752969881244;8182.386321025947;8187.140350263256;8199.95900020496;8209.466384684976;8243.464174828618;8245.628946697412;8245.670173193004;8253.215944485144;8275.172482751677;6332.461740752087;7074.823129421599;7601.65792539326;7874.803129921798;7902.4863383879865;7062;7666.080070391366;7687.654055567625;7693.269139431745;7694.730684426018;6651.035599838093;8209.79475513093;8219.95890020546;8246.463979841292;8249.175082491704;4835.3714017178945;4878.219484882402;4882.755862206946;4893.266010098514;4917.237828136645;7556.2443755624;7644.235576442311;7690.154083050748;7874.251946065115;7881.408894332833;6201.255849298113;7561.7731468056045;7582.772516824504;7592.544447333178;7598.354139898171;7581.279778421042;7583.924160758543;7592.126905405728;7602.163761986288;7633.12219094789;7381.557106573623;7393.593352365671;7411.518251313647;7415.740449084256;7448.8882666758955;7276.199618042117;7595.506292090997;7598.620068996639;7615.124260710089;7629.2752188542;7336.7432139874845;7371.004914336496;7405.629718513945;7416.555006699616;7424.703011879465 09:38:35 INFO - PROCESS | 2588 | |5;yui.html;678.2708588267612;697.2086681616365;725.5791640848308;747.2350813474046;786.4376970466116;12104.636860894165;15363.001404908673;15383.153926534036;15578.298976546068;15619.297131629075;12901.838834504893;13873.722525549483;14486.130832150053;14493.347799349029;14509.347079381427;766.9923300767005;944.57022054965;954.7231302922179;987.3187500624582;987.4075554667178;957.8754761880981;972.4311277902435;974;974.6442548469793;977.5796407544752;1013.8935411781767;1018.45003698003;1019.0930072235716;1023.3246057601984;1024.4877561219391;1002.4636819301711;1015.2943704125636;1016.6899095775785;1016.8474728790703;1021.6832781837617;675.7398401615413;736.5359823311334;747.312472525278;759.3128218961848;768.1320108277611;14904.62738431537;14935.850641493555;15027.924860375737;15140.848591514054;15156.393744250217;13242.536511222157;13285.003624728088;13297.734045319135;13300.401481933337;13453.327333633279;10071.431784894878;10081.949590252001;10278;10304.072633463024;10394.168466522735;3548.361294966931;3566.037169964121;3581.83881725323;3632.691221246197;3804.524434445694;67022;90942.54528727314;91854;92837.53581232051;94617;9830.557624906896;9939.453330066772;10012.64955726546;10030.74923126913;10187.286889917634;23085.769142308698;23167.420814479774;23597;23658.171963981178;23699.763002370102;7576.886346704804;7683.577403242875;7703.383729301642;7876.881846772303;7904.762857114296;3943.3493473576536;4141.979290103591;4201.222773786859;4213.536510983789;4224.408582798411;3699.574548926854;3738.36447803874;3740.869069582606;3745.8127093645207;3769.962300377016;649.7660842096841;658.3186402073926;659.8053574195624;661.3287513174132;661.3948237362855;588.7321268822675;594.9583529153005;595.7527626035234;604.274870155806;605.8485378655337;8498.702545411004;8521.275691566163;8557.914420855712;8675.869861952076;8732.738017859474;587.9000569903127;599.3766482857866;615.5567991046439;615.9335429633516;626.2672672972633;3821.7706937583835;3919.522062843547;3971.404289356562;3981.223661386002;4211.094614657802;99917.50041249747;100599;101033;101373;103958.48020759848;60391.39608603946;73747.63126184334;77879.61060194662;78188;78362.21637783549;60276.39723602796;76299.23700763032;76594.61702691563;77263;77451;7808.492447990862;7855.529579585447;8103.554304513308;8134.877976830234;8308.667653294042;51184.74407627938;51211.487885120674;51745.48254517407;52584;52812.47187528075;67007;69543.65228173826;71579.28420715727;71615.92576111258;72970;8619;10567.260291779501;10715;10771.246012779031;10848.349099054081;10924.344539327665;11214.271072380268;11345.773084538429;11438.485268162785;11451.59919402817;10192.949035254776;10473.266871318934;10657.20070994694;10714.517846697074;10847;10377.014183652542;10448.373097614167;10578.735531611463;10711.517981690688;10826.51280692355;10253.231007674305;10322.845157322796;10337.328073675188;10577.735556610838;11320.09439244875;8942.50816205089;9082.091790821129;9126.908730912606;9183.17351438347;9232.492212928353;8944.150305720947;9052.54737263121;9178.495182764746;9182.816343673223;9264.258859291105 09:38:35 INFO - PROCESS | 2588 | __end_tp_report 09:38:35 INFO - PROCESS | 2588 | __start_cc_report 09:38:35 INFO - PROCESS | 2588 | _x_x_mozilla_cycle_collect,358 09:38:35 INFO - PROCESS | 2588 | __end_cc_report 09:38:35 INFO - PROCESS | 2588 | __startTimestamp1458232715729__endTimestamp 09:38:35 INFO - PROCESS | 2588 | 09:38:35 INFO - PROCESS | 2588 | ------- Summary: start ------- 09:38:35 INFO - PROCESS | 2588 | Number of tests: 6 09:38:35 INFO - PROCESS | 2588 | 09:38:35 INFO - PROCESS | 2588 | [#0] dojo.html Cycles:165 Average:5871.94 Median:6121.54 stddev:635.68 (10.4%) stddev-sans-first:599.33 09:38:35 INFO - PROCESS | 2588 | Values: 3101.6 3525.7 3550.9 3560.8 3619.6 5926.9 5946.5 5949.3 5966.9 5969.0 5945.1 5957.8 5979.6 6019.3 6043.3 5327.1 5350.3 5405.8 5426.0 5474.8 5267.1 5376.5 5385.2 5408.6 5415.5 5376.3 5398.6 5405.8 5409.4 5410.4 5326.5 5364.8 5417.7 5438.9 5443.0 5305.4 5370.2 5371.1 5385.3 5411.4 5557.8 5673.7 5710.7 5925.3 6067.2 6240.7 6249.2 6255.8 6256.9 6288.7 6335.8 6341.8 6345.1 6356.6 6358.0 5978.8 6044.3 6057.6 6090.7 6110.9 6469.1 6473.2 6493.4 6512.3 6590.0 6238.7 6253.6 6259.7 6262.7 6304.7 6199.3 6279.6 6279.6 6335.6 6342.3 6192.7 6226.6 6263.7 6265.9 6388.5 6121.5 6207.2 6260.0 6281.2 6291.8 5000.2 5032.6 5043.7 5049.3 5088.6 4473.0 4483.1 4525.1 4535.4 4541.1 5757.3 5839.1 5973.0 5980.8 6003.1 6224.4 6241.0 6249.4 6339.7 6345.6 5960.5 5999.4 6004.6 6014.1 6049.4 5414.0 5543.3 5551.4 5567.1 5569.9 5524.4 6458.8 6550.7 6581.7 6582.5 6274.3 6303.8 6307.7 6314.8 6315.8 6311.3 6499.2 6510.5 6586.4 6593.3 6184.2 6262.2 6265.6 6277.7 6287.2 6288.8 6301.7 6309.6 6310.7 6313.6 6143.1 6153.7 6211.3 6248.1 6262.5 6220.3 6226.4 6229.4 6238.7 6256.8 6097.2 6141.4 6228.7 6238.5 6248.2 5371.4 6111.6 6145.9 6151.6 6166.8 5248.8 5613.8 5834.4 6141.8 6252.2 09:38:35 INFO - PROCESS | 2588 | 09:38:35 INFO - PROCESS | 2588 | [#1] ext.html Cycles:180 Average:58719.60 Median:38264.71 stddev:119272.01 (311.7%) stddev-sans-first:119526.70 09:38:35 INFO - PROCESS | 2588 | Values: 571.5 598.8 608.7 656.8 675.1 30389.2 38608.6 38705.6 38772.2 39099.6 40368.4 40600.6 40884.8 40896.6 40975.0 9458.2 9603.2 9644.3 9645.6 9680.3 9495.8 9710.2 9767.7 9795.9 9822.3 9827.0 9828.4 9836.9 9842.7 9852.3 9758.1 9814.4 9828.5 9840.4 9857.1 9664.5 9757.8 9772.3 9781.3 9784.6 33767.5 34120.5 40392.4 40573.4 40775.6 3096.4 3112.6 3232.4 3297.9 3407.3 27393.0 27436.0 27522.7 27808.0 29636.0 2663.6 2768.2 2778.5 2797.8 2845.2 310877.0 313676.4 313918.4 314137.0 314171.9 48273.3 48732.8 69343.7 69613.0 69836.0 46321.0 46569.0 46603.8 46676.0 46751.5 14078.8 16367.1 16823.3 16879.6 16947.0 13614.0 13693.2 13723.9 13736.9 13743.2 13021.2 14526.2 14891.6 15004.6 15019.6 6462.5 6620.2 6640.6 6647.5 6655.3 991.6 1049.2 1094.0 1105.5 1203.0 28896.3 29049.3 29598.1 30406.4 30918.8 990.0 1097.4 1137.5 1139.3 1293.8 15332.7 15642.9 15759.8 15786.8 15990.8 554355.0 563085.0 563422.2 564568.0 565089.0 62558.0 63279.0 63736.7 63772.7 63819.4 1507.3 1537.5 1543.4 1545.8 1553.4 21860.7 29117.0 30008.8 30409.4 30990.8 54470.0 54476.0 54804.5 54818.9 54848.0 378042.0 445816.0 446987.0 447424.0 447778.0 30065.7 33144.3 34956.3 35565.0 35622.3 46454.0 47171.3 47694.0 47830.8 48230.5 38195.0 38321.0 39337.0 39356.2 39440.0 37359.9 37662.8 37828.4 38128.2 38208.4 32896.5 37260.1 38119.8 38435.0 38903.0 29992.0 31115.8 31140.2 31151.0 31220.2 25089.1 25286.0 25316.0 25571.5 25651.7 09:38:35 INFO - PROCESS | 2588 | 09:38:35 INFO - PROCESS | 2588 | [#2] jquery.html Cycles:180 Average:38045.47 Median:11725.93 stddev:115299.89 (983.3%) stddev-sans-first:115588.58 09:38:35 INFO - PROCESS | 2588 | Values: 344.6 371.7 385.1 385.2 387.8 20207.9 21044.0 21466.6 22181.6 22220.8 21311.9 21447.2 21672.0 21741.0 21843.9 4455.0 5652.8 5674.6 5907.7 5910.2 5660.0 5756.4 5772.9 5780.7 5801.9 5639.9 5643.3 5728.1 5728.3 5732.8 5644.3 5732.2 5751.6 5799.2 5828.1 5071.5 5079.6 5086.6 5111.2 5117.9 18247.5 23251.3 24226.2 24949.6 25336.7 2130.4 2140.0 2148.0 2238.4 2257.6 10203.5 10322.3 12858.3 14060.3 14484.6 1801.8 1835.8 1838.6 1855.5 1856.2 96803.0 116596.4 117240.0 119793.4 120046.4 9617.5 9833.5 11955.9 12036.8 12086.6 12156.1 14299.4 14439.4 14467.3 14497.3 7516.8 8221.8 8458.2 9005.8 9290.6 7816.5 9219.0 9224.3 9249.5 9320.1 4586.8 4660.1 4665.0 4702.2 4707.6 1653.1 1967.1 1975.4 1980.9 2019.6 921.6 943.6 966.0 980.5 1013.4 17082.7 18384.8 19426.0 19954.8 20106.8 981.3 984.4 1022.1 1028.7 1035.3 10856.7 11074.6 11083.2 11086.5 11353.9 680502.6 689112.0 697698.0 704250.5 710024.0 123071.2 125809.0 125953.0 127819.0 128004.0 897.9 976.5 992.7 993.4 1000.1 16106.6 18297.9 18372.6 18385.6 18567.8 51879.7 52215.2 53661.2 54141.6 56754.4 80574.8 81479.2 82226.0 84737.6 89993.1 11136.8 11258.2 11964.5 12167.4 12570.3 11903.6 13375.8 14038.2 14143.2 14388.9 11883.4 11892.9 12125.8 12180.8 12227.2 11736.7 11921.9 11946.5 11949.9 12035.9 5979.7 12080.3 12135.9 12165.5 12213.7 11765.1 12139.2 12177.4 12280.9 12386.8 12110.1 12122.6 12156.1 12277.8 12331.4 09:38:35 INFO - PROCESS | 2588 | 09:38:35 INFO - PROCESS | 2588 | [#3] mootools.html Cycles:180 Average:6421.60 Median:2858.52 stddev:3423.43 (119.8%) stddev-sans-first:3414.44 09:38:35 INFO - PROCESS | 2588 | Values: 1673.9 1690.2 1777.3 1906.4 2092.8 8412.1 9090.7 9209.2 9423.0 9455.0 9282.9 9307.7 9372.7 9391.2 9396.6 2604.7 2611.6 2619.9 2627.6 2632.4 2543.0 2585.8 2590.5 2592.1 2594.3 2370.1 2557.5 2590.8 2608.2 2614.0 2460.8 2563.6 2587.4 2590.3 2596.9 2235.6 2566.0 2595.5 2596.7 2617.8 9477.3 9495.0 9533.1 9553.5 9562.7 5710.7 5913.1 5929.6 5931.7 5968.0 3635.8 3700.4 3767.3 3799.6 3847.6 1044.8 1059.9 1060.7 1082.7 1104.7 11320.5 12219.5 12577.7 12648.9 12750.4 5110.5 5134.5 5228.6 5234.2 5244.5 10840.6 10861.5 10868.4 10871.9 10890.4 5655.6 5761.7 5774.8 5861.8 5879.1 4677.5 5061.2 5112.7 5199.6 5200.3 4127.1 4195.9 4199.1 4207.6 4209.3 1179.6 1369.5 1385.1 1396.0 1405.3 1388.0 1455.5 1461.9 1482.4 1485.1 8637.5 8690.7 8723.2 8738.6 8742.1 517.4 527.5 534.2 534.6 535.2 6432.5 6451.9 6500.8 6501.7 6511.3 11244.0 11561.0 11622.1 11655.0 11718.2 11245.2 11260.4 11408.3 11503.5 11511.2 8763.5 8880.4 8943.4 8959.1 8983.4 8161.1 8326.6 8329.5 8369.9 8381.4 10123.7 10200.7 10205.5 10343.3 10349.3 10349.1 10372.1 10648.7 10648.8 10679.9 6691.3 7112.5 7573.4 7740.2 7928.4 8715.4 8732.7 8771.3 8835.2 8837.0 7639.4 7907.8 7936.2 7968.5 7971.6 7644.3 7699.6 7717.5 7789.6 7807.8 8176.5 8240.8 8287.0 8290.2 8297.9 7358.7 7361.1 7369.1 7455.1 7470.3 7442.6 7450.6 7512.5 7537.9 7543.4 09:38:35 INFO - PROCESS | 2588 | 09:38:35 INFO - PROCESS | 2588 | [#4] prototype.html Cycles:180 Average:6121.48 Median:6942.69 stddev:1965.31 (28.3%) stddev-sans-first:1921.80 09:38:35 INFO - PROCESS | 2588 | Values: 309.9 314.3 328.2 347.7 348.8 7013.2 7046.5 7050.9 7060.3 7100.9 6949.8 6961.4 7040.1 7056.9 7072.7 4903.6 4972.8 5088.1 5099.6 5102.5 5059.6 5112.3 5115.1 5159.9 5168.2 5109.3 5114.2 5116.1 5117.2 5130.7 5124.9 5128.2 5129.7 5134.2 5137.0 4394.0 4399.5 4404.9 4413.8 4420.2 6668.9 6676.8 6752.9 6782.1 6838.1 6020.8 6071.9 6074.8 6075.8 6075.9 7503.8 7517.5 7535.5 7537.4 7574.7 4111.0 4947.9 4950.9 4951.2 4957.6 7149.5 7849.2 7959.6 7997.5 8003.1 4908.6 4972.5 4980.3 4990.6 4991.0 5069.2 5097.3 5098.2 5101.4 5107.3 5314.9 5639.4 5983.5 5993.6 6006.3 6168.9 7543.2 7560.5 7603.6 7607.1 1683.9 1712.6 1741.9 1779.1 1783.0 1159.7 1164.8 1167.6 1170.7 1180.1 6928.2 6935.5 6961.1 6979.9 6997.9 6377.5 7803.5 7811.3 7820.0 7841.9 6031.2 6625.3 6934.6 6970.7 6986.4 3956.9 4100.9 4125.6 4131.9 4134.2 8118.6 8140.3 8172.7 8182.2 8186.9 6175.8 8182.4 8187.1 8200.0 8209.5 8243.5 8245.6 8245.7 8253.2 8275.2 6332.5 7074.8 7601.7 7874.8 7902.5 7062.0 7666.1 7687.7 7693.3 7694.7 6651.0 8209.8 8220.0 8246.5 8249.2 4835.4 4878.2 4882.8 4893.3 4917.2 7556.2 7644.2 7690.2 7874.3 7881.4 6201.3 7561.8 7582.8 7592.5 7598.4 7581.3 7583.9 7592.1 7602.2 7633.1 7381.6 7393.6 7411.5 7415.7 7448.9 7276.2 7595.5 7598.6 7615.1 7629.3 7336.7 7371.0 7405.6 7416.6 7424.7 09:38:35 INFO - PROCESS | 2588 | 09:38:35 INFO - PROCESS | 2588 | [#5] yui.html Cycles:180 Average:18837.21 Median:27704.58 stddev:27181.97 (98.1%) stddev-sans-first:27224.03 09:38:35 INFO - PROCESS | 2588 | Values: 678.3 697.2 725.6 747.2 786.4 12104.6 15363.0 15383.2 15578.3 15619.3 12901.8 13873.7 14486.1 14493.3 14509.3 767.0 944.6 954.7 987.3 987.4 957.9 972.4 974.0 974.6 977.6 1013.9 1018.5 1019.1 1023.3 1024.5 1002.5 1015.3 1016.7 1016.8 1021.7 675.7 736.5 747.3 759.3 768.1 14904.6 14935.9 15027.9 15140.8 15156.4 13242.5 13285.0 13297.7 13300.4 13453.3 10071.4 10081.9 10278.0 10304.1 10394.2 3548.4 3566.0 3581.8 3632.7 3804.5 67022.0 90942.5 91854.0 92837.5 94617.0 9830.6 9939.5 10012.6 10030.7 10187.3 23085.8 23167.4 23597.0 23658.2 23699.8 7576.9 7683.6 7703.4 7876.9 7904.8 3943.3 4142.0 4201.2 4213.5 4224.4 3699.6 3738.4 3740.9 3745.8 3770.0 649.8 658.3 659.8 661.3 661.4 588.7 595.0 595.8 604.3 605.8 8498.7 8521.3 8557.9 8675.9 8732.7 587.9 599.4 615.6 615.9 626.3 3821.8 3919.5 3971.4 3981.2 4211.1 99917.5 100599.0 101033.0 101373.0 103958.5 60391.4 73747.6 77879.6 78188.0 78362.2 60276.4 76299.2 76594.6 77263.0 77451.0 7808.5 7855.5 8103.6 8134.9 8308.7 51184.7 51211.5 51745.5 52584.0 52812.5 67007.0 69543.7 71579.3 71615.9 72970.0 8619.0 10567.3 10715.0 10771.2 10848.3 10924.3 11214.3 11345.8 11438.5 11451.6 10192.9 10473.3 10657.2 10714.5 10847.0 10377.0 10448.4 10578.7 10711.5 10826.5 10253.2 10322.8 10337.3 10577.7 11320.1 8942.5 9082.1 9126.9 9183.2 9232.5 8944.2 9052.5 9178.5 9182.8 9264.3 09:38:35 INFO - PROCESS | 2588 | -------- Summary: end -------- 09:38:35 INFO - PROCESS | 2588 | 09:38:36 INFO - TEST-INFO | 2588: exit 0 09:38:36 INFO - TEST-OK | dromaeo_css | took 1111763ms 09:38:36 INFO - TEST-START | kraken 09:38:36 INFO - operating with platform_type : mac_ 09:38:36 INFO - Initialising browser for kraken test... 09:38:36 INFO - TEST-INFO | started process 2593 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpNpSQPz/profile http://localhost:51885/getInfo.html) 09:38:38 INFO - PROCESS | 2593 | __metrics Screen width/height:1600/1200 09:38:38 INFO - PROCESS | 2593 | colorDepth:24 09:38:38 INFO - PROCESS | 2593 | Browser inner width/height: 1024/689 09:38:38 INFO - PROCESS | 2593 | __metrics 09:38:39 ERROR - PROCESS | 2593 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:38:39 INFO - TEST-INFO | 2593: exit 0 09:38:39 INFO - Browser initialized. 09:38:39 INFO - Running cycle 1/1 for kraken test... 09:38:39 INFO - TEST-INFO | started process 2596 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpNpSQPz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:51 INFO - PROCESS | 2596 | RSS: Main: 219492352 09:38:51 INFO - PROCESS | 2596 | 09:38:54 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:51885/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51885/tests/kraken/driver.html?testName=audio-beat-detection) 09:38:54 INFO - PROCESS | 2596 | RSS: Main: 231174144 09:38:54 INFO - PROCESS | 2596 | 09:38:57 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:51885/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51885/tests/kraken/driver.html?testName=audio-dft) 09:38:58 INFO - PROCESS | 2596 | RSS: Main: 241577984 09:38:58 INFO - PROCESS | 2596 | 09:39:01 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:51885/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51885/tests/kraken/driver.html?testName=audio-fft) 09:39:01 INFO - PROCESS | 2596 | RSS: Main: 244346880 09:39:01 INFO - PROCESS | 2596 | 09:39:03 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:51885/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51885/tests/kraken/driver.html?testName=audio-oscillator) 09:39:04 INFO - PROCESS | 2596 | RSS: Main: 245170176 09:39:04 INFO - PROCESS | 2596 | 09:39:06 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:51885/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51885/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:39:07 INFO - PROCESS | 2596 | RSS: Main: 245764096 09:39:07 INFO - PROCESS | 2596 | 09:39:09 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:51885/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51885/tests/kraken/driver.html?testName=imaging-darkroom) 09:39:10 INFO - PROCESS | 2596 | RSS: Main: 247107584 09:39:10 INFO - PROCESS | 2596 | 09:39:13 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:51885/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51885/tests/kraken/driver.html?testName=imaging-desaturate) 09:39:13 INFO - PROCESS | 2596 | RSS: Main: 247386112 09:39:13 INFO - PROCESS | 2596 | 09:39:16 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:51885/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51885/tests/kraken/driver.html?testName=json-parse-financial) 09:39:17 INFO - PROCESS | 2596 | RSS: Main: 246964224 09:39:17 INFO - PROCESS | 2596 | 09:39:19 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:51885/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51885/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:39:19 INFO - PROCESS | 2596 | RSS: Main: 245772288 09:39:19 INFO - PROCESS | 2596 | 09:39:21 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:51885/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51885/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:39:22 INFO - PROCESS | 2596 | RSS: Main: 246661120 09:39:22 INFO - PROCESS | 2596 | 09:39:24 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:51885/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51885/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:39:24 INFO - PROCESS | 2596 | RSS: Main: 246177792 09:39:24 INFO - PROCESS | 2596 | 09:39:27 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:51885/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:27 INFO - PROCESS | 2596 | RSS: Main: 246431744 09:39:27 INFO - PROCESS | 2596 | 09:39:30 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:51885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:31 INFO - PROCESS | 2596 | RSS: Main: 247582720 09:39:31 INFO - PROCESS | 2596 | 09:39:32 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:51885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51885/tests/kraken/driver.html?testName=ai-astar) 09:39:33 INFO - PROCESS | 2596 | RSS: Main: 249700352 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | __start_tp_report 09:39:33 INFO - PROCESS | 2596 | _x_x_mozilla_page_load 09:39:33 INFO - PROCESS | 2596 | _x_x_mozilla_page_load_details 09:39:33 INFO - PROCESS | 2596 | |i|pagename|runs| 09:39:33 INFO - PROCESS | 2596 | |0;ai-astar;117;114;115;132;167;167;116;112;116;116 09:39:33 INFO - PROCESS | 2596 | |1;audio-beat-detection;150;136;155;143;117;136;148;117;160;121 09:39:33 INFO - PROCESS | 2596 | |2;audio-dft;196;195;191;198;203;197;199;200;199;199 09:39:33 INFO - PROCESS | 2596 | |3;audio-fft;70;70;72;114;55;60;58;61;166;78 09:39:33 INFO - PROCESS | 2596 | |4;audio-oscillator;87;86;122;79;78;82;121;79;79;124 09:39:33 INFO - PROCESS | 2596 | |5;imaging-gaussian-blur;135;130;88;85;89;86;88;85;89;85 09:39:33 INFO - PROCESS | 2596 | |6;imaging-darkroom;94;94;95;94;95;94;94;94;94;93 09:39:33 INFO - PROCESS | 2596 | |7;imaging-desaturate;144;147;91;92;92;91;93;109;149;127 09:39:33 INFO - PROCESS | 2596 | |8;json-parse-financial;54;57;58;72;60;58;60;65;57;53 09:39:33 INFO - PROCESS | 2596 | |9;json-stringify-tinderbox;66;65;70;68;90;103;96;68;68;68 09:39:33 INFO - PROCESS | 2596 | |10;stanford-crypto-aes;82;82;108;108;83;81;84;82;84;83 09:39:33 INFO - PROCESS | 2596 | |11;stanford-crypto-ccm;120;117;122;122;119;127;142;120;105;124 09:39:33 INFO - PROCESS | 2596 | |12;stanford-crypto-pbkdf2;126;134;134;137;133;133;157;168;132;127 09:39:33 INFO - PROCESS | 2596 | |13;stanford-crypto-sha256-iterative;63;98;89;92;98;86;66;62;67;70 09:39:33 INFO - PROCESS | 2596 | __end_tp_report 09:39:33 INFO - PROCESS | 2596 | __start_cc_report 09:39:33 INFO - PROCESS | 2596 | _x_x_mozilla_cycle_collect,920 09:39:33 INFO - PROCESS | 2596 | __end_cc_report 09:39:33 INFO - PROCESS | 2596 | __startTimestamp1458232773090__endTimestamp 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | ------- Summary: start ------- 09:39:33 INFO - PROCESS | 2596 | Number of tests: 14 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | [#0] ai-astar Cycles:10 Average:127.20 Median:116.50 stddev:21.67 (18.6%) stddev-sans-first:22.67 09:39:33 INFO - PROCESS | 2596 | Values: 117.0 114.0 115.0 132.0 167.0 167.0 116.0 112.0 116.0 116.0 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:145.50 stddev:15.71 (10.8%) stddev-sans-first:16.08 09:39:33 INFO - PROCESS | 2596 | Values: 150.0 136.0 155.0 143.0 117.0 136.0 148.0 117.0 160.0 121.0 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | [#2] audio-dft Cycles:10 Average:197.70 Median:199.00 stddev:3.23 (1.6%) stddev-sans-first:3.37 09:39:33 INFO - PROCESS | 2596 | Values: 196.0 195.0 191.0 198.0 203.0 197.0 199.0 200.0 199.0 199.0 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | [#3] audio-fft Cycles:10 Average:80.40 Median:65.50 stddev:34.46 (52.6%) stddev-sans-first:36.35 09:39:33 INFO - PROCESS | 2596 | Values: 70.0 70.0 72.0 114.0 55.0 60.0 58.0 61.0 166.0 78.0 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:79.00 stddev:20.00 (25.3%) stddev-sans-first:21.07 09:39:33 INFO - PROCESS | 2596 | Values: 87.0 86.0 122.0 79.0 78.0 82.0 121.0 79.0 79.0 124.0 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | [#5] imaging-gaussian-blur Cycles:10 Average:96.00 Median:87.00 stddev:19.34 (22.2%) stddev-sans-first:14.47 09:39:33 INFO - PROCESS | 2596 | Values: 135.0 130.0 88.0 85.0 89.0 86.0 88.0 85.0 89.0 85.0 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:39:33 INFO - PROCESS | 2596 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 93.0 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | [#7] imaging-desaturate Cycles:10 Average:113.50 Median:91.00 stddev:25.54 (28.1%) stddev-sans-first:24.59 09:39:33 INFO - PROCESS | 2596 | Values: 144.0 147.0 91.0 92.0 92.0 91.0 93.0 109.0 149.0 127.0 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:59.00 stddev:5.54 (9.4%) stddev-sans-first:5.52 09:39:33 INFO - PROCESS | 2596 | Values: 54.0 57.0 58.0 72.0 60.0 58.0 60.0 65.0 57.0 53.0 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | [#9] json-stringify-tinderbox Cycles:10 Average:76.20 Median:68.00 stddev:14.29 (21.0%) stddev-sans-first:14.67 09:39:33 INFO - PROCESS | 2596 | Values: 66.0 65.0 70.0 68.0 90.0 103.0 96.0 68.0 68.0 68.0 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:82.50 stddev:10.74 (13.0%) stddev-sans-first:11.19 09:39:33 INFO - PROCESS | 2596 | Values: 82.0 82.0 108.0 108.0 83.0 81.0 84.0 82.0 84.0 83.0 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:122.00 stddev:9.19 (7.5%) stddev-sans-first:9.72 09:39:33 INFO - PROCESS | 2596 | Values: 120.0 117.0 122.0 122.0 119.0 127.0 142.0 120.0 105.0 124.0 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.10 Median:134.00 stddev:13.52 (10.1%) stddev-sans-first:13.61 09:39:33 INFO - PROCESS | 2596 | Values: 126.0 134.0 134.0 137.0 133.0 133.0 157.0 168.0 132.0 127.0 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - PROCESS | 2596 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.10 Median:87.50 stddev:14.83 (16.9%) stddev-sans-first:14.54 09:39:33 INFO - PROCESS | 2596 | Values: 63.0 98.0 89.0 92.0 98.0 86.0 66.0 62.0 67.0 70.0 09:39:33 INFO - PROCESS | 2596 | -------- Summary: end -------- 09:39:33 INFO - PROCESS | 2596 | 09:39:33 INFO - TEST-INFO | 2596: exit 0 09:39:33 INFO - TEST-OK | kraken | took 57590ms 09:39:33 INFO - SUITE-END | took 1169s 09:39:34 INFO - Completed test suite (00:19:29) 09:39:34 INFO - javascript benchmark 09:39:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3101.5502752100947, 3525.7003154731838, 3550.91697032405, 3560.8041557714314, 3619.60184379718, 5926.851828704284, 5946.494547963428, 5949.286085669715, 5966.850828729284, 5968.9701551492235, 5945.108233764938, 5957.821265362035, 5979.551533634973, 6019.307779605347, 6043.305019922699, 5327.121025030875, 5350.30446042016, 5405.837824865261, 5426.0, 5474.808381706641, 5267.1309233976535, 5376.489233522809, 5385.165299378583, 5408.648437851547, 5415.458454154573, 5376.301080859483, 5398.595105367093, 5405.756740946647, 5409.377921539034, 5410.3507579090565, 5326.493983071602, 5364.839054828361, 5417.674939503623, 5438.864028399282, 5442.965836491054, 5305.4164041955355, 5370.22131790892, 5371.086915224421, 5385.2999110115825, 5411.377691565481, 5557.833265002016, 5673.716314184274, 5710.7430165642645, 5925.31858836235, 6067.211262535886, 6240.687965601702, 6249.218847644044, 6255.843603909893, 6256.937430625681, 6288.685565721696, 6335.778247761353, 6341.8414539636415, 6345.07996340528, 6356.618602883842, 6358.0, 5978.790742323998, 6044.274687037496, 6057.575969682124, 6090.695465226721, 6110.862540392742, 6469.126667899867, 6473.2232132144445, 6493.383128602775, 6512.251091124582, 6590.0, 6238.65687387189, 6253.624782513064, 6259.7496100156395, 6262.718177682015, 6304.71628776697, 6199.256089269316, 6279.560430769893, 6279.623222606659, 6335.619862808247, 6342.302346741854, 6192.659403732748, 6226.62640241587, 6263.749450021948, 6265.937340626535, 6388.4569811566535, 6121.540884433685, 6207.193064901534, 6259.968700156561, 6281.183446151971, 6291.7797877075, 5000.1749711297225, 5032.647714659939, 5043.747812609355, 5049.267856160836, 5088.643794934393, 4473.015936493966, 4483.103379324149, 4525.094981003813, 4535.365048893158, 4541.069080838421, 5757.337906140848, 5839.124131380327, 5972.984592619265, 5980.820575382745, 6003.129546215774, 6224.37756224383, 6241.0, 6249.375062493714, 6339.651319177489, 6345.587536810092, 5960.493358064527, 5999.430054144849, 6004.609700369462, 6014.127951447016, 6049.364816694272, 5414.0, 5543.334799824047, 5551.3893471718075, 5567.053600887778, 5569.944300556943, 5524.4199359066715, 6458.806235812933, 6550.737970481127, 6581.736730530725, 6582.539222254588, 6274.309825919237, 6303.779367722291, 6307.716152773228, 6314.842128946813, 6315.810525684236, 6311.305756366704, 6499.155109835691, 6510.544261901811, 6586.407223349922, 6593.307702691149, 6184.165137706532, 6262.185915830913, 6265.592736472115, 6277.748890044347, 6287.1512345832725, 6288.811335659938, 6301.684915754286, 6309.621422714652, 6310.6844657766005, 6313.621182729051, 6143.051335358963, 6153.661548614869, 6211.254649442096, 6248.0940263660605, 6262.4990000800735, 6220.284667263322, 6226.40849119333, 6229.408206220402, 6238.656873871981, 6256.843578910563, 6097.237845269341, 6141.385861414002, 6228.719707613078, 6238.469730072813, 6248.218972628421, 5371.355437347544, 6111.561351782648, 6145.863015342176, 6151.569390142647, 6166.81499555014, 5248.816291429782, 5613.803516876889, 5834.416558344132, 6141.823559979257, 6252.187215661935], "unit": "score", "name": "dojo.html", "value": 5832.453090947822}, {"lowerIsBetter": false, "replicates": [571.5313442976758, 598.7634884220732, 608.7199888051496, 656.7504348347627, 675.0751470485436, 30389.240268993257, 38608.613913860856, 38705.612943870554, 38772.224555508874, 39099.60900390995, 40368.39447408291, 40600.59399406005, 40884.79557602208, 40896.591034089724, 40975.0, 9458.196053335458, 9603.18372938301, 9644.276679249084, 9645.614175432975, 9680.273979451535, 9495.81008379832, 9710.223182145412, 9767.658131965383, 9795.853062204073, 9822.312438129335, 9826.950865245664, 9828.361156524803, 9836.852447213298, 9842.655507057254, 9852.26108041896, 9758.121769040785, 9814.411135331831, 9828.508574571242, 9840.376337904238, 9857.063578959987, 9664.468454235015, 9757.756056098584, 9772.267079969031, 9781.266405019582, 9784.55969481375, 33767.493487597705, 34120.48819267713, 40392.39411408831, 40573.39139912904, 40775.59224407777, 3096.4426403247408, 3112.564241006261, 3232.402005628966, 3297.884574039897, 3407.30150319184, 27393.0, 27436.03973860925, 27522.724772752215, 27808.02671906494, 29635.962741304167, 2663.613776002488, 2768.183385901144, 2778.458200650874, 2797.8181418207955, 2845.1891211004972, 310877.0, 313676.43161784275, 313918.4304078488, 314137.0, 314171.85828141886, 48273.27590086152, 48732.7563362188, 69343.65328173428, 69613.0, 69836.0, 46321.0, 46569.0, 46603.766981164874, 46676.0, 46751.5324846754, 14078.788818167735, 16367.099809510592, 16823.327066917187, 16879.578010549834, 16947.0, 13613.97895157867, 13693.246871422167, 13723.862761372258, 13736.93131534356, 13743.244121573409, 13021.153625014344, 14526.20105894186, 14891.553253402415, 15004.62488437776, 15019.624509387353, 6462.547621666438, 6620.205575330991, 6640.634765087966, 6647.501437392215, 6655.267920528738, 991.6033586565287, 1049.150188347441, 1093.9507722152364, 1105.4638500327335, 1202.9518819247307, 28896.277593060342, 29049.27376815554, 29598.112056638336, 30406.391872162876, 30918.845405773278, 989.9505024748734, 1097.3635291530893, 1137.4995002199005, 1139.2708666453477, 1293.7818046419263, 15332.693346133015, 15642.921785391229, 15759.842401575837, 15786.842131578767, 15990.840091599168, 554355.0, 563085.0, 563422.1828890911, 564568.0, 565089.0, 62558.0, 63279.0, 63736.68131659312, 63772.68113659402, 63819.36180638134, 1507.2539093148741, 1537.48494254426, 1543.4135028689027, 1545.8299587045642, 1553.4407613259218, 21860.672089918982, 29117.0, 30008.84995575008, 30409.39181216319, 30990.845045775528, 54470.0, 54476.0, 54804.45195547993, 54818.90362192813, 54848.0, 378042.0, 445816.0, 446987.0, 447424.0, 447778.0, 30065.69934300629, 33144.33711325808, 34956.30087398289, 35565.0, 35622.28755424825, 46454.0, 47171.292430612884, 47694.04611907673, 47830.760846195546, 48230.5176948226, 38195.0, 38321.0, 39337.01657458472, 39356.212875742895, 39440.0, 37359.87920362393, 37662.81168594139, 37828.43257351087, 38128.23743525169, 38208.42687359636, 32896.51965661503, 37260.06849828776, 38119.80940095393, 38435.03912402212, 38903.02742431462, 29992.0, 31115.837176021912, 31140.22149446282, 31151.0, 31220.219494512818, 25089.12188073409, 25286.0, 25316.0, 25571.488570228863, 25651.743482564936], "unit": "score", "name": "ext.html", "value": 19377.486332442502}, {"lowerIsBetter": false, "replicates": [344.6105900332624, 371.70449492653336, 385.0931057359918, 385.16419369967184, 387.80609695152424, 20207.898960505194, 21044.0, 21466.570668586657, 22181.556368872614, 22220.777792222074, 21311.893440532775, 21447.249346272885, 21672.0, 21741.021654025568, 21843.890780546077, 4455.042165934332, 5652.773889044433, 5674.631148975303, 5907.704614769265, 5910.202122713443, 5660.0, 5756.395578464264, 5772.942270577303, 5780.682062486561, 5801.883962320751, 5639.8590035249035, 5643.322801263854, 5728.083506638938, 5728.25532680753, 5732.79935202268, 5644.322681278232, 5732.22614946981, 5751.568632352549, 5799.18811366409, 5828.1257811328005, 5071.543561079484, 5079.619028572835, 5086.618503612207, 5111.207762796773, 5117.872053198663, 18247.54381140469, 23251.302460926032, 24226.152084677127, 24949.62575561368, 25336.733163341945, 2130.38218916514, 2139.962118372588, 2147.95704085919, 2238.4068221921043, 2257.600287821545, 10203.540840662188, 10322.277440579162, 12858.292793896331, 14060.296985150702, 14484.565463036126, 1801.8108098649584, 1835.7613510243716, 1838.6138910828743, 1855.5361159710073, 1856.1740025688573, 96803.0319696801, 116596.41701791521, 117240.0, 119793.40103299514, 120046.3997680006, 9617.471039092778, 9833.508324583741, 11955.88044119565, 12036.81944770829, 12086.576969806014, 12156.149069565046, 14299.428022879176, 14439.35022923971, 14467.27663616815, 14497.275136243357, 7516.849663006709, 8221.753347399588, 8458.154184581615, 9005.819883602422, 9290.581923813445, 7816.53100813953, 9219.032001639865, 9224.30817688676, 9249.491277979641, 9320.114589114024, 4586.770661466913, 4660.114578230193, 4665.043666048452, 4702.200625893606, 4707.599854012379, 1653.148628456346, 1967.1147983407525, 1975.3580086471954, 1980.8910509922093, 2019.636745196986, 921.635953798246, 943.6366998705548, 966.0484422843493, 980.4999450280266, 1013.366645846346, 17082.743758843626, 18384.81615183858, 19426.0, 19954.800451995583, 20106.82185064854, 981.254246772458, 984.4044353166374, 1022.0648106982177, 1028.6708253359002, 1035.3322107240788, 10856.72858178536, 11074.612388566522, 11083.224174307721, 11086.501107450184, 11353.886461135447, 680502.5974870094, 689112.0, 697698.0, 704250.478747603, 710024.0, 123071.15393269109, 125809.0, 125953.0, 127819.0, 128004.0, 897.8877640294963, 976.4629453800381, 992.6575331510618, 993.4287784523783, 1000.1498726082772, 16106.597335066717, 18297.90212587249, 18372.632547349247, 18385.632287354445, 18567.81432185715, 51879.740601296755, 52215.21677174921, 53661.19508207302, 54141.64645883884, 56754.432455676564, 80574.79137813055, 81479.18520814716, 82226.0, 84737.57631211805, 89993.10006900108, 11136.777264454828, 11258.155638327322, 11964.521419143137, 12167.39163041862, 12570.308633024906, 11903.631082425285, 13375.799363009368, 14038.1577105374, 14143.222122783345, 14388.85611143917, 11883.405829708307, 11892.940535297268, 12125.818112728493, 12180.817287740514, 12227.205231659913, 11736.70658233551, 11921.940390297994, 11946.522139114339, 11949.880501194877, 12035.879641203475, 5979.730912109053, 12080.275183489019, 12135.878641213474, 12165.513379465076, 12213.69465763363, 11765.11761617865, 12139.210951288138, 12177.391130443266, 12280.877191227974, 12386.81419778686, 12110.091743119478, 12122.575709850113, 12156.149069565046, 12277.815832762695, 12331.44508497102], "unit": "score", "name": "jquery.html", "value": 9893.67820537931}, {"lowerIsBetter": false, "replicates": [1673.9079350635714, 1690.180262572652, 1777.3334999375227, 1906.3994841624879, 2092.811646951774, 8412.074671786115, 9090.681826136086, 9209.171174594285, 9423.0, 9455.00722424145, 9282.907170928289, 9307.72076837696, 9372.671956481507, 9391.154796068353, 9396.577154028068, 2604.661394018775, 2611.5690910999756, 2619.882105305256, 2627.6452678888295, 2632.4340266842623, 2543.0, 2585.7802086822644, 2590.520753660579, 2592.092767531368, 2594.2736033910537, 2370.1230544698487, 2557.475717477922, 2590.844549327037, 2608.191460647196, 2614.0066774625616, 2460.753924607534, 2563.628273900274, 2587.4178309880126, 2590.2617753940226, 2596.8961241550314, 2235.564065007324, 2565.961510577343, 2595.4679290745353, 2596.7143614202423, 2617.751313625203, 9477.28920330971, 9494.95252523733, 9533.142017218484, 9553.474558899257, 9562.713118606453, 5710.714464276811, 5913.113033045035, 5929.555283353722, 5931.673757943311, 5968.045112781934, 3635.781853088823, 3700.4079347304573, 3767.2842159989514, 3799.639034291738, 3847.615238476158, 1044.843273508972, 1059.8940105989338, 1060.7242117049545, 1082.6697857153565, 1104.7403860092872, 11320.547178112865, 12219.511219551207, 12577.685557861036, 12648.936755316257, 12750.362481875869, 5110.463401342806, 5134.486551344836, 5228.607854410859, 5234.18870075139, 5244.501772331622, 10840.566377344818, 10861.511231994578, 10868.402237876993, 10871.891281087246, 10890.401027943539, 5655.632383895034, 5761.740721667535, 5774.769009239667, 5861.824145275648, 5879.147523609053, 4677.4854765975715, 5061.215511595708, 5112.71880046601, 5199.610029247821, 5200.323957885526, 4127.09203975125, 4195.895102622459, 4199.0552125772065, 4207.600277973587, 4209.284421648327, 1179.55177032727, 1369.5069774881035, 1385.0789225165354, 1396.0, 1405.3184205660248, 1387.9722405552034, 1455.4542046732474, 1461.875740562064, 1482.4440834686993, 1485.094092603511, 8637.481751094954, 8690.652373904974, 8723.171298726611, 8738.606762695694, 8742.082081381363, 517.4385791416355, 527.5489456514701, 534.1640332879032, 534.5750128647734, 535.1865164949334, 6432.517561182836, 6451.903221451682, 6500.837479063061, 6501.674916254168, 6511.283758786624, 11244.0, 11561.0, 11622.07023438123, 11655.009324207367, 11718.23831450953, 11245.212835101627, 11260.380679062566, 11408.258463199865, 11503.539858405737, 11511.19421640477, 8763.518006509576, 8880.37837351392, 8943.37396382247, 8959.148880856308, 8983.416077954913, 8161.143079976517, 8326.583670816555, 8329.541875196923, 8369.874451883104, 8381.413301068867, 10123.696289111338, 10200.744981375525, 10205.489725513546, 10343.27597068198, 10349.27555071168, 10349.120324772479, 10372.066514013775, 10648.733781655521, 10648.84026739584, 10679.946600266949, 6691.297413771484, 7112.537685050662, 7573.431992600687, 7740.187280335484, 7928.445008849325, 8715.38992270535, 8732.738017859474, 8771.298296136421, 8835.160659737314, 8837.0, 7639.427042971688, 7907.802304942423, 7936.246056624612, 7968.521888686466, 7971.561564114029, 7644.273793989562, 7699.576523291273, 7717.498362606412, 7789.649465774167, 7807.804804879696, 8176.509409435453, 8240.752777416687, 8287.046989596032, 8290.170982901662, 8297.875531866906, 7358.66885990121, 7361.079865016873, 7369.078865141857, 7455.0681164854395, 7470.3276705096805, 7442.553446793209, 7450.552966822008, 7512.511686740344, 7537.924620753723, 7543.35881450061], "unit": "score", "name": "mootools.html", "value": 5132.298904482822}, {"lowerIsBetter": false, "replicates": [309.91942095055276, 314.3194982862104, 328.2008309765719, 347.71661096206606, 348.7959543666954, 7013.228544860061, 7046.5067445278855, 7050.85898282034, 7060.293970602937, 7100.928990710091, 6949.826254343644, 6961.373476387124, 7040.119985001875, 7056.858862822741, 7072.66602021333, 4903.632227582928, 4972.825951091712, 5088.084144853925, 5099.592032637399, 5102.489751024905, 5059.6458247922665, 5112.284280200774, 5115.10485665009, 5159.936025589775, 5168.224766285069, 5109.284700141983, 5114.207297868837, 5116.1302578561545, 5117.232415137741, 5130.743462826862, 5124.92312615311, 5128.205128205134, 5129.692218466904, 5134.204198349262, 5136.9743151284, 4393.989382442024, 4399.472063352418, 4404.889877753049, 4413.845515406977, 4420.226460369422, 6668.93331066688, 6676.766313179064, 6752.93247067528, 6782.118324617817, 6838.111045564045, 6020.759169633209, 6071.908921366183, 6074.817755467343, 6075.756969721206, 6075.939240607581, 7503.849923001564, 7517.5113617615225, 7535.547867127935, 7537.397008239328, 7574.734884279023, 4111.0, 4947.876303092416, 4950.9009819803405, 4951.207806750938, 4957.628177886673, 7149.49953503255, 7849.175836537195, 7959.641816118288, 7997.520148791033, 8003.079645840745, 4908.558229759267, 4972.527609877128, 4980.327655766425, 4990.600751939836, 4990.975045124751, 5069.188929771219, 5097.260897169889, 5098.209777484496, 5101.362329708786, 5107.259447380109, 5314.937012597496, 5639.351474580476, 5983.461488466059, 5993.580449368589, 6006.339302676702, 6168.938310616926, 7543.170251272356, 7560.546367217985, 7603.581803000888, 7607.125180604191, 1683.9242234099495, 1712.623222890962, 1741.9390321338947, 1779.128227168678, 1783.028249603969, 1159.704275409782, 1164.8369228308043, 1167.5913430299327, 1170.7424366639325, 1180.0972256223995, 6928.16861976566, 6935.549189302679, 6961.095057642474, 6979.89530157048, 6997.93002069983, 6377.489800815923, 7803.492772969739, 7811.257930496708, 7819.960900195462, 7841.921580784233, 6031.24609423822, 6625.3374662534325, 6934.613077384543, 6970.651467426608, 6986.371226589631, 3956.8615098471414, 4100.91798164035, 4125.587441255911, 4131.855385061569, 4134.214499245134, 8118.594070296462, 8140.3487720982175, 8172.6730930762105, 8182.22268884455, 8186.918130818615, 6175.752969881244, 8182.386321025947, 8187.140350263256, 8199.95900020496, 8209.466384684976, 8243.464174828618, 8245.628946697412, 8245.670173193004, 8253.215944485144, 8275.172482751677, 6332.461740752087, 7074.823129421599, 7601.65792539326, 7874.803129921798, 7902.4863383879865, 7062.0, 7666.080070391366, 7687.654055567625, 7693.269139431745, 7694.730684426018, 6651.035599838093, 8209.79475513093, 8219.95890020546, 8246.463979841292, 8249.175082491704, 4835.3714017178945, 4878.219484882402, 4882.755862206946, 4893.266010098514, 4917.237828136645, 7556.2443755624, 7644.235576442311, 7690.154083050748, 7874.251946065115, 7881.408894332833, 6201.255849298113, 7561.7731468056045, 7582.772516824504, 7592.544447333178, 7598.354139898171, 7581.279778421042, 7583.924160758543, 7592.126905405728, 7602.163761986288, 7633.12219094789, 7381.557106573623, 7393.593352365671, 7411.518251313647, 7415.740449084256, 7448.8882666758955, 7276.199618042117, 7595.506292090997, 7598.620068996639, 7615.124260710089, 7629.2752188542, 7336.7432139874845, 7371.004914336496, 7405.629718513945, 7416.555006699616, 7424.703011879465], "unit": "score", "name": "prototype.html", "value": 5462.084771493357}, {"lowerIsBetter": false, "replicates": [678.2708588267612, 697.2086681616365, 725.5791640848308, 747.2350813474046, 786.4376970466116, 12104.636860894165, 15363.001404908673, 15383.153926534036, 15578.298976546068, 15619.297131629075, 12901.838834504893, 13873.722525549483, 14486.130832150053, 14493.347799349029, 14509.347079381427, 766.9923300767005, 944.57022054965, 954.7231302922179, 987.3187500624582, 987.4075554667178, 957.8754761880981, 972.4311277902435, 974.0, 974.6442548469793, 977.5796407544752, 1013.8935411781767, 1018.45003698003, 1019.0930072235716, 1023.3246057601984, 1024.4877561219391, 1002.4636819301711, 1015.2943704125636, 1016.6899095775785, 1016.8474728790703, 1021.6832781837617, 675.7398401615413, 736.5359823311334, 747.312472525278, 759.3128218961848, 768.1320108277611, 14904.62738431537, 14935.850641493555, 15027.924860375737, 15140.848591514054, 15156.393744250217, 13242.536511222157, 13285.003624728088, 13297.734045319135, 13300.401481933337, 13453.327333633279, 10071.431784894878, 10081.949590252001, 10278.0, 10304.072633463024, 10394.168466522735, 3548.361294966931, 3566.037169964121, 3581.83881725323, 3632.691221246197, 3804.524434445694, 67022.0, 90942.54528727314, 91854.0, 92837.53581232051, 94617.0, 9830.557624906896, 9939.453330066772, 10012.64955726546, 10030.74923126913, 10187.286889917634, 23085.769142308698, 23167.420814479774, 23597.0, 23658.171963981178, 23699.763002370102, 7576.886346704804, 7683.577403242875, 7703.383729301642, 7876.881846772303, 7904.762857114296, 3943.3493473576536, 4141.979290103591, 4201.222773786859, 4213.536510983789, 4224.408582798411, 3699.574548926854, 3738.36447803874, 3740.869069582606, 3745.8127093645207, 3769.962300377016, 649.7660842096841, 658.3186402073926, 659.8053574195624, 661.3287513174132, 661.3948237362855, 588.7321268822675, 594.9583529153005, 595.7527626035234, 604.274870155806, 605.8485378655337, 8498.702545411004, 8521.275691566163, 8557.914420855712, 8675.869861952076, 8732.738017859474, 587.9000569903127, 599.3766482857866, 615.5567991046439, 615.9335429633516, 626.2672672972633, 3821.7706937583835, 3919.522062843547, 3971.404289356562, 3981.223661386002, 4211.094614657802, 99917.50041249747, 100599.0, 101033.0, 101373.0, 103958.48020759848, 60391.39608603946, 73747.63126184334, 77879.61060194662, 78188.0, 78362.21637783549, 60276.39723602796, 76299.23700763032, 76594.61702691563, 77263.0, 77451.0, 7808.492447990862, 7855.529579585447, 8103.554304513308, 8134.877976830234, 8308.667653294042, 51184.74407627938, 51211.487885120674, 51745.48254517407, 52584.0, 52812.47187528075, 67007.0, 69543.65228173826, 71579.28420715727, 71615.92576111258, 72970.0, 8619.0, 10567.260291779501, 10715.0, 10771.246012779031, 10848.349099054081, 10924.344539327665, 11214.271072380268, 11345.773084538429, 11438.485268162785, 11451.59919402817, 10192.949035254776, 10473.266871318934, 10657.20070994694, 10714.517846697074, 10847.0, 10377.014183652542, 10448.373097614167, 10578.735531611463, 10711.517981690688, 10826.51280692355, 10253.231007674305, 10322.845157322796, 10337.328073675188, 10577.735556610838, 11320.09439244875, 8942.50816205089, 9082.091790821129, 9126.908730912606, 9183.17351438347, 9232.492212928353, 8944.150305720947, 9052.54737263121, 9178.495182764746, 9182.816343673223, 9264.258859291105], "unit": "score", "name": "yui.html", "value": 7018.338337726889}], "name": "dromaeo_css", "value": 7769.750841323135}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 114.0, 115.0, 132.0, 167.0, 167.0, 116.0, 112.0, 116.0, 116.0], "unit": "score", "name": "ai-astar", "value": 127.2}, {"lowerIsBetter": true, "replicates": [150.0, 136.0, 155.0, 143.0, 117.0, 136.0, 148.0, 117.0, 160.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 138.3}, {"lowerIsBetter": true, "replicates": [196.0, 195.0, 191.0, 198.0, 203.0, 197.0, 199.0, 200.0, 199.0, 199.0], "unit": "score", "name": "audio-dft", "value": 197.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 72.0, 114.0, 55.0, 60.0, 58.0, 61.0, 166.0, 78.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 122.0, 79.0, 78.0, 82.0, 121.0, 79.0, 79.0, 124.0], "unit": "score", "name": "audio-oscillator", "value": 93.7}, {"lowerIsBetter": true, "replicates": [135.0, 130.0, 88.0, 85.0, 89.0, 86.0, 88.0, 85.0, 89.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 94.1}, {"lowerIsBetter": true, "replicates": [144.0, 147.0, 91.0, 92.0, 92.0, 91.0, 93.0, 109.0, 149.0, 127.0], "unit": "score", "name": "imaging-desaturate", "value": 113.5}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 58.0, 72.0, 60.0, 58.0, 60.0, 65.0, 57.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 70.0, 68.0, 90.0, 103.0, 96.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 76.2}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 108.0, 108.0, 83.0, 81.0, 84.0, 82.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.7}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 122.0, 122.0, 119.0, 127.0, 142.0, 120.0, 105.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [126.0, 134.0, 134.0, 137.0, 133.0, 133.0, 157.0, 168.0, 132.0, 127.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.1}, {"lowerIsBetter": true, "replicates": [63.0, 98.0, 89.0, 92.0, 98.0, 86.0, 66.0, 62.0, 67.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 79.1}], "name": "kraken", "value": 1503.1999999999998}]} 09:39:34 INFO - Return code: 0 09:39:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:39:34 ERROR - # TBPL SUCCESS # 09:39:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:39:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:39:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:39:34 INFO - 2016-03-17 09:39:34.406 screenresolution[2601:40621] starting screenresolution argv=screenresolution get 09:39:34 INFO - 2016-03-17 09:39:34.409 screenresolution[2601:40621] Display 0: 1600x1200x32@60 09:39:34 INFO - 2016-03-17 09:39:34.415 screenresolution[2602:40624] starting screenresolution argv=screenresolution list 09:39:34 INFO - Available Modes on Display 0 09:39:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:39:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:39:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:39:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:39:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:39:34 INFO - Intel Iris: 09:39:34 INFO - Chipset Model: Intel Iris 09:39:34 INFO - Type: GPU 09:39:34 INFO - Bus: Built-In 09:39:34 INFO - VRAM (Dynamic, Max): 1536 MB 09:39:34 INFO - Vendor: Intel (0x8086) 09:39:34 INFO - Device ID: 0x0a2e 09:39:34 INFO - Revision ID: 0x0009 09:39:34 INFO - Displays: 09:39:34 INFO - Display: 09:39:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:39:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:39:34 INFO - Display Serial Number: 1600x1200 60 09:39:34 INFO - Main Display: Yes 09:39:34 INFO - Mirror: Off 09:39:34 INFO - Online: Yes 09:39:34 INFO - Rotation: Supported 09:39:34 INFO - Return code: 0 09:39:34 INFO - Running post-action listener: _resource_record_post_action 09:39:34 INFO - Running post-run listener: _resource_record_post_run 09:39:35 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 196608; Write bytes: 664614912; Read time: 1; Write time: 2318 09:39:35 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 357886464; Write bytes: 353363456; Read time: 28051; Write time: 638 09:39:35 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 196608; Write bytes: 300077568; Read time: 1; Write time: 1518 09:39:35 INFO - Running post-run listener: _upload_blobber_files 09:39:35 INFO - Blob upload gear active. 09:39:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:35 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:39:35 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:39:35 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:39:36 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:39:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:36 INFO - (blobuploader) - INFO - Done attempting. 09:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:39:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:37 INFO - (blobuploader) - INFO - Done attempting. 09:39:37 INFO - (blobuploader) - INFO - Iteration through files over. 09:39:37 INFO - Return code: 0 09:39:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40b574fdf3eb1fe22acc0282beff4e7461161b0410bd3dae8666940c0403345e8bce5cf6d775d5722fe32e0530bef198181d3e1e114a439eeb6b080837e7a7f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed4b43020509e46df6daadca1bca6df3888045e235c2cd89561e05bba07118fe65068287dcdc0057e68d67b17ba9032e7944b33780adbdc2f08389879c3d3b75"} 09:39:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:37 INFO - Contents: 09:39:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40b574fdf3eb1fe22acc0282beff4e7461161b0410bd3dae8666940c0403345e8bce5cf6d775d5722fe32e0530bef198181d3e1e114a439eeb6b080837e7a7f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed4b43020509e46df6daadca1bca6df3888045e235c2cd89561e05bba07118fe65068287dcdc0057e68d67b17ba9032e7944b33780adbdc2f08389879c3d3b75"} 09:39:37 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:37 INFO - Copying logs to upload dir... 09:39:37 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.225779 ========= master_lag: 2.96 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-17 09:39:40.757408) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 09:39:40.763122) ========= 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.fR1lPDCOpf/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.WODF0XjIG8/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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/Mozilla-Aurora/sha512/40b574fdf3eb1fe22acc0282beff4e7461161b0410bd3dae8666940c0403345e8bce5cf6d775d5722fe32e0530bef198181d3e1e114a439eeb6b080837e7a7f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed4b43020509e46df6daadca1bca6df3888045e235c2cd89561e05bba07118fe65068287dcdc0057e68d67b17ba9032e7944b33780adbdc2f08389879c3d3b75"} build_url:https://queue.taskcluster.net/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/HXwVpty_R7iBqOIkVeTxgw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40b574fdf3eb1fe22acc0282beff4e7461161b0410bd3dae8666940c0403345e8bce5cf6d775d5722fe32e0530bef198181d3e1e114a439eeb6b080837e7a7f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed4b43020509e46df6daadca1bca6df3888045e235c2cd89561e05bba07118fe65068287dcdc0057e68d67b17ba9032e7944b33780adbdc2f08389879c3d3b75"}' ========= master_lag: 0.28 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 09:39:41.050411) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:39:41.053764) ========= 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.fR1lPDCOpf/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.WODF0XjIG8/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005236 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:39:41.108745) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 09:39:41.109031) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 09:39:41.109680) ========= ========= Total master_lag: 3.47 =========