builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0175 starttime: 1455628688.34 results: success (0) buildid: 20160216030245 builduid: 6a59ac61660b4d67a07fa64db5a5cd1c revision: 6ea654cad929c9bedd8a4161a182b6189fbeae6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.343945) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.344339) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.344634) ========= 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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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.006036 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.405810) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.406080) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.564969) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.565230) ========= 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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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.005584 ========= master_lag: 0.41 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.979759) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.980020) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.980372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.980653) ========= 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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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-02-16 05:18:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.51M=0.001s 2016-02-16 05:18:09 (8.51 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158073 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:09.234770) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:09.235041) ========= 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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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.019473 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:09.271270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-16 05:18:09.271631) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6ea654cad929c9bedd8a4161a182b6189fbeae6a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6ea654cad929c9bedd8a4161a182b6189fbeae6a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CZHDZ7T8x9/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.skAZRhLSwY/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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-02-16 05:18:09,340 truncating revision to first 12 chars 2016-02-16 05:18:09,340 Setting DEBUG logging. 2016-02-16 05:18:09,340 attempt 1/10 2016-02-16 05:18:09,340 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6ea654cad929?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-16 05:18:10,304 unpacking tar archive at: mozilla-central-6ea654cad929/testing/mozharness/ program finished with exit code 0 elapsedTime=1.214941 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-16 05:18:10.504876) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:10.505495) ========= echo 6ea654cad929c9bedd8a4161a182b6189fbeae6a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6ea654cad929c9bedd8a4161a182b6189fbeae6a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CZHDZ7T8x9/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.skAZRhLSwY/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 6ea654cad929c9bedd8a4161a182b6189fbeae6a program finished with exit code 0 elapsedTime=0.004944 script_repo_revision: '6ea654cad929c9bedd8a4161a182b6189fbeae6a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:10.558727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:10.559300) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:10.586573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2016-02-16 05:18:10.586859) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CZHDZ7T8x9/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.skAZRhLSwY/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 05:18:10 INFO - MultiFileLogger online at 20160216 05:18:10 in /builds/slave/test 05:18:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:18:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:18:10 INFO - {'append_to_log': False, 05:18:10 INFO - 'base_work_dir': '/builds/slave/test', 05:18:10 INFO - 'blob_upload_branch': 'Firefox', 05:18:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:18:10 INFO - 'branch': 'Firefox', 05:18:10 INFO - 'buildbot_json_path': 'buildprops.json', 05:18:10 INFO - 'config_files': ('talos/mac_config.py',), 05:18:10 INFO - 'default_actions': ('clobber', 05:18:10 INFO - 'read-buildbot-config', 05:18:10 INFO - 'download-and-extract', 05:18:10 INFO - 'populate-webroot', 05:18:10 INFO - 'create-virtualenv', 05:18:10 INFO - 'install', 05:18:10 INFO - 'run-tests'), 05:18:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:18:10 INFO - 'download_minidump_stackwalk': True, 05:18:10 INFO - 'download_symbols': 'ondemand', 05:18:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:18:10 INFO - 'tooltool.py': '/tools/tooltool.py', 05:18:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:18:10 INFO - '/tools/misc-python/virtualenv.py')}, 05:18:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:18:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:18:10 INFO - 'installer_path': 'installer.exe', 05:18:10 INFO - 'log_level': 'info', 05:18:10 INFO - 'log_name': 'talos', 05:18:10 INFO - 'log_to_console': True, 05:18:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:18:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:18:10 INFO - 'opt_config_files': (), 05:18:10 INFO - 'pip_index': False, 05:18:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:18:10 INFO - 'cmd': ('bash', 05:18:10 INFO - '-c', 05:18:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:18:10 INFO - 'enabled': True, 05:18:10 INFO - 'halt_on_failure': False, 05:18:10 INFO - 'name': 'check_screen_resolution'},), 05:18:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:18:10 INFO - 'cmd': ('bash', 05:18:10 INFO - '-c', 05:18:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:18:10 INFO - 'enabled': True, 05:18:10 INFO - 'halt_on_failure': False, 05:18:10 INFO - 'name': 'check_screen_resolution'},), 05:18:10 INFO - 'run_cmd_checks_enabled': True, 05:18:10 INFO - 'sps_profile': False, 05:18:10 INFO - 'sps_profile_interval': 0, 05:18:10 INFO - 'suite': 'dromaeojs-e10s', 05:18:10 INFO - 'system_bits': '32', 05:18:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:18:10 INFO - 'title': 't-yosemite-r7-0175', 05:18:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:18:10 INFO - 'use_talos_json': True, 05:18:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:18:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:18:10 INFO - 'work_dir': 'build'} 05:18:10 INFO - ##### 05:18:10 INFO - ##### Running clobber step. 05:18:10 INFO - ##### 05:18:10 INFO - Running pre-action listener: _resource_record_pre_action 05:18:10 INFO - Running main action method: clobber 05:18:10 INFO - rmtree: /builds/slave/test/build 05:18:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:18:12 INFO - Running post-action listener: _resource_record_post_action 05:18:12 INFO - ##### 05:18:12 INFO - ##### Running read-buildbot-config step. 05:18:12 INFO - ##### 05:18:12 INFO - Running pre-action listener: _resource_record_pre_action 05:18:12 INFO - Running main action method: read_buildbot_config 05:18:12 INFO - Using buildbot properties: 05:18:12 INFO - { 05:18:12 INFO - "project": "", 05:18:12 INFO - "product": "firefox", 05:18:12 INFO - "script_repo_revision": "production", 05:18:12 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:18:12 INFO - "repository": "", 05:18:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:18:12 INFO - "buildid": "20160216030245", 05:18:12 INFO - "stage_platform": "macosx64", 05:18:12 INFO - "basedir": "/builds/slave/test", 05:18:12 INFO - "nightly_build": "True", 05:18:12 INFO - "buildnumber": 110, 05:18:12 INFO - "slavename": "t-yosemite-r7-0175", 05:18:12 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:18:12 INFO - "platform": "yosemite_r7", 05:18:12 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:18:12 INFO - "branch": "mozilla-central", 05:18:12 INFO - "repo_path": "mozilla-central", 05:18:12 INFO - "revision": "6ea654cad929c9bedd8a4161a182b6189fbeae6a", 05:18:12 INFO - "pgo_build": "False", 05:18:12 INFO - "builduid": "6a59ac61660b4d67a07fa64db5a5cd1c", 05:18:12 INFO - "slavebuilddir": "test" 05:18:12 INFO - } 05:18:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 05:18:12 INFO - Running post-action listener: _resource_record_post_action 05:18:12 INFO - ##### 05:18:12 INFO - ##### Running download-and-extract step. 05:18:12 INFO - ##### 05:18:12 INFO - Running pre-action listener: _resource_record_pre_action 05:18:12 INFO - Running main action method: download_and_extract 05:18:12 INFO - mkdir: /builds/slave/test/build/tests 05:18: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')]} 05:18:12 INFO - https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:18:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/test_packages.json 05:18:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/test_packages.json 05:18:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:18:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:18:43 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/test_packages.json: timed out 05:18:43 INFO - retry: attempt #1 caught exception: timed out 05:18:43 INFO - retry: Failed, sleeping 30 seconds before retrying 05:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #2 05:19:34 INFO - Downloaded 1277 bytes. 05:19:34 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:19:34 INFO - Using the following test package requirements: 05:19:34 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:19:34 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:19:34 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 05:19:34 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:19:34 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 05:19:34 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:19:34 INFO - u'jsshell-mac.zip'], 05:19:34 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:19:34 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 05:19:34 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:19:34 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:19:34 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 05:19:34 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:19:34 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 05:19:34 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:19:34 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 05:19:34 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:19:34 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:19:34 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 05:19:34 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:34 INFO - https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:19:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:19:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:19:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:19:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:19:37 INFO - Downloaded 17803184 bytes. 05:19:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:19:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:19:40 INFO - Return code: 0 05:19:40 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:19: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')]} 05:19:40 INFO - https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:19:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:19:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:19:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:19:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:19:41 INFO - Downloaded 17803184 bytes. 05:19:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:19:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:19:45 INFO - Return code: 0 05:19:45 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')]} 05:19:45 INFO - https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:19:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:19:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:19:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:19:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:19:46 INFO - Downloaded 10707071 bytes. 05:19:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:19:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:19:46 INFO - Return code: 0 05:19: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')]} 05:19:46 INFO - https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:19:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:19:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:19:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 05:19:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 05:19:49 INFO - Downloaded 111283151 bytes. 05:19:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:19:49 INFO - mkdir: /builds/slave/test/properties 05:19:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:19:49 INFO - Writing to file /builds/slave/test/properties/build_url 05:19:49 INFO - Contents: 05:19:49 INFO - build_url:https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:19:50 INFO - Running post-action listener: _resource_record_post_action 05:19:50 INFO - Running post-action listener: set_extra_try_arguments 05:19:50 INFO - ##### 05:19:50 INFO - ##### Running populate-webroot step. 05:19:50 INFO - ##### 05:19:50 INFO - Running pre-action listener: _resource_record_pre_action 05:19:50 INFO - Running main action method: populate_webroot 05:19:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:19:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:19:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:19:50 INFO - '--tppagecycles', 05:19:50 INFO - '7'], 05:19:50 INFO - 'tests': ['tsvgm']}}, 05:19:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:19:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:19:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:19:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:19:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:19:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:19:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:50 INFO - 'talos_options': ['--e10s'], 05:19:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:50 INFO - 'tests': ['damp', 'tps']}, 05:19:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:50 INFO - 'talos_options': ['--e10s'], 05:19:50 INFO - 'tests': ['damp', 'tps']}, 05:19:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:19:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:19:50 INFO - 'other': {'tests': ['a11yr', 05:19:50 INFO - 'ts_paint', 05:19:50 INFO - 'tpaint', 05:19:50 INFO - 'sessionrestore', 05:19:50 INFO - 'sessionrestore_no_auto_restore']}, 05:19:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:19:50 INFO - 'tests': ['a11yr', 05:19:50 INFO - 'ts_paint', 05:19:50 INFO - 'tpaint', 05:19:50 INFO - 'sessionrestore', 05:19:50 INFO - 'sessionrestore_no_auto_restore']}, 05:19:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:19:50 INFO - 'tests': ['a11yr', 05:19:50 INFO - 'ts_paint', 05:19:50 INFO - 'tpaint', 05:19:50 INFO - 'sessionrestore', 05:19:50 INFO - 'sessionrestore_no_auto_restore']}, 05:19:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:19:50 INFO - 'tests': ['a11yr', 05:19:50 INFO - 'ts_paint', 05:19:50 INFO - 'tpaint', 05:19:50 INFO - 'sessionrestore', 05:19:50 INFO - 'sessionrestore_no_auto_restore']}, 05:19:50 INFO - 'other_l64': {'tests': ['a11yr', 05:19:50 INFO - 'ts_paint', 05:19:50 INFO - 'tpaint', 05:19:50 INFO - 'sessionrestore', 05:19:50 INFO - 'sessionrestore_no_auto_restore']}, 05:19:50 INFO - 'other_nol64': {'tests': ['a11yr', 05:19:50 INFO - 'ts_paint', 05:19:50 INFO - 'tpaint', 05:19:50 INFO - 'sessionrestore', 05:19:50 INFO - 'sessionrestore_no_auto_restore']}, 05:19:50 INFO - 'svgr': {'tests': ['tsvgx', 05:19:50 INFO - 'tsvgr_opacity', 05:19:50 INFO - 'tart', 05:19:50 INFO - 'tscrollx', 05:19:50 INFO - 'cart']}, 05:19:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:19:50 INFO - 'tests': ['tsvgx', 05:19:50 INFO - 'tsvgr_opacity', 05:19:50 INFO - 'tart', 05:19:50 INFO - 'tscrollx', 05:19:50 INFO - 'cart']}, 05:19:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:50 INFO - 'tests': ['tp5o']}, 05:19:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:50 INFO - 'talos_options': ['--e10s'], 05:19:50 INFO - 'tests': ['tp5o']}, 05:19:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:50 INFO - 'talos_options': ['--xperf_path', 05:19:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:50 INFO - 'tests': ['tp5n']}, 05:19:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:50 INFO - 'talos_options': ['--e10s', 05:19:50 INFO - '--xperf_path', 05:19:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:50 INFO - 'tests': ['tp5n']}}, 05:19:50 INFO - 'talos.zip': {'path': '', 05:19:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:19:50 INFO - Running post-action listener: _resource_record_post_action 05:19:50 INFO - ##### 05:19:50 INFO - ##### Running create-virtualenv step. 05:19:50 INFO - ##### 05:19:50 INFO - Running pre-action listener: _resource_record_pre_action 05:19:50 INFO - Running main action method: create_virtualenv 05:19:50 INFO - Creating virtualenv /builds/slave/test/build/venv 05:19:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:19:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:19:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:19:50 INFO - Using real prefix '/tools/python27' 05:19:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:19:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:19:54 INFO - Installing pip.................done. 05:19:54 INFO - Return code: 0 05:19:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017f5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcccb4a3940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101699d30>, '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 0x1014bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101690b20>, '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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 05:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:19:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZHDZ7T8x9/Render', 05:19:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:54 INFO - 'HOME': '/Users/cltbld', 05:19:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:54 INFO - 'LOGNAME': 'cltbld', 05:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:54 INFO - 'MOZ_NO_REMOTE': '1', 05:19:54 INFO - 'NO_EM_RESTART': '1', 05:19:54 INFO - 'PAGER': '/bin/cat', 05:19:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:54 INFO - 'PWD': '/builds/slave/test', 05:19:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:54 INFO - 'SHELL': '/bin/bash', 05:19:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skAZRhLSwY/Listeners', 05:19:54 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:19:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:54 INFO - 'USER': 'cltbld', 05:19:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:54 INFO - 'XPC_FLAGS': '0x0', 05:19:54 INFO - 'XPC_SERVICE_NAME': '0', 05:19:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:19:54 INFO - Cleaning up... 05:19:54 INFO - Return code: 0 05:19:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017f5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcccb4a3940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101699d30>, '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 0x1014bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101690b20>, '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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 05:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:19:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZHDZ7T8x9/Render', 05:19:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:54 INFO - 'HOME': '/Users/cltbld', 05:19:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:54 INFO - 'LOGNAME': 'cltbld', 05:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:54 INFO - 'MOZ_NO_REMOTE': '1', 05:19:54 INFO - 'NO_EM_RESTART': '1', 05:19:54 INFO - 'PAGER': '/bin/cat', 05:19:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:54 INFO - 'PWD': '/builds/slave/test', 05:19:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:54 INFO - 'SHELL': '/bin/bash', 05:19:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skAZRhLSwY/Listeners', 05:19:54 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:19:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:54 INFO - 'USER': 'cltbld', 05:19:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:54 INFO - 'XPC_FLAGS': '0x0', 05:19:54 INFO - 'XPC_SERVICE_NAME': '0', 05:19:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:54 INFO - Downloading/unpacking psutil>=0.7.1 05:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:19:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:57 INFO - Installing collected packages: psutil 05:19:57 INFO - Running setup.py install for psutil 05:19:57 INFO - building 'psutil._psutil_osx' extension 05:19:57 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 05:19:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:19:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:19:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:19:58 INFO - building 'psutil._psutil_posix' extension 05:19:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:19:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:19:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:19:58 INFO - ^ 05:19:58 INFO - 1 warning generated. 05:19:58 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 05:19:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:58 INFO - Successfully installed psutil 05:19:58 INFO - Cleaning up... 05:19:58 INFO - Return code: 0 05:19:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:58 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 0x1017f5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcccb4a3940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101699d30>, '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 0x1014bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101690b20>, '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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 05:19:58 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 05:19:58 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 05:19:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZHDZ7T8x9/Render', 05:19:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:58 INFO - 'HOME': '/Users/cltbld', 05:19:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:58 INFO - 'LOGNAME': 'cltbld', 05:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:58 INFO - 'MOZ_NO_REMOTE': '1', 05:19:58 INFO - 'NO_EM_RESTART': '1', 05:19:58 INFO - 'PAGER': '/bin/cat', 05:19:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:58 INFO - 'PWD': '/builds/slave/test', 05:19:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:58 INFO - 'SHELL': '/bin/bash', 05:19:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skAZRhLSwY/Listeners', 05:19:58 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:19:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:58 INFO - 'USER': 'cltbld', 05:19:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:58 INFO - 'XPC_FLAGS': '0x0', 05:19:58 INFO - 'XPC_SERVICE_NAME': '0', 05:19:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:20:01 INFO - Installing collected packages: mozsystemmonitor 05:20:01 INFO - Running setup.py install for mozsystemmonitor 05:20:01 INFO - Successfully installed mozsystemmonitor 05:20:01 INFO - Cleaning up... 05:20:01 INFO - Return code: 0 05:20:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:01 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 0x1017f5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcccb4a3940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101699d30>, '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 0x1014bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101690b20>, '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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 05:20:01 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 05:20:01 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 05:20:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZHDZ7T8x9/Render', 05:20:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:20:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:20:01 INFO - 'HOME': '/Users/cltbld', 05:20:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:20:01 INFO - 'LOGNAME': 'cltbld', 05:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:01 INFO - 'MOZ_NO_REMOTE': '1', 05:20:01 INFO - 'NO_EM_RESTART': '1', 05:20:01 INFO - 'PAGER': '/bin/cat', 05:20:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:01 INFO - 'PWD': '/builds/slave/test', 05:20:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:20:01 INFO - 'SHELL': '/bin/bash', 05:20:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skAZRhLSwY/Listeners', 05:20:01 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:20:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:20:01 INFO - 'USER': 'cltbld', 05:20:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:20:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:01 INFO - 'XPC_FLAGS': '0x0', 05:20:01 INFO - 'XPC_SERVICE_NAME': '0', 05:20:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:01 INFO - Downloading/unpacking blobuploader==1.2.4 05:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:04 INFO - Downloading blobuploader-1.2.4.tar.gz 05:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:20:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:20:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:05 INFO - Downloading docopt-0.6.1.tar.gz 05:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:20:05 INFO - Installing collected packages: blobuploader, requests, docopt 05:20:05 INFO - Running setup.py install for blobuploader 05:20:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:20:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:20:05 INFO - Running setup.py install for requests 05:20:06 INFO - Running setup.py install for docopt 05:20:06 INFO - Successfully installed blobuploader requests docopt 05:20:06 INFO - Cleaning up... 05:20:06 INFO - Return code: 0 05:20:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017f5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcccb4a3940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101699d30>, '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 0x1014bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101690b20>, '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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 05:20:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:20:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZHDZ7T8x9/Render', 05:20:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:20:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:20:06 INFO - 'HOME': '/Users/cltbld', 05:20:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:20:06 INFO - 'LOGNAME': 'cltbld', 05:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:06 INFO - 'MOZ_NO_REMOTE': '1', 05:20:06 INFO - 'NO_EM_RESTART': '1', 05:20:06 INFO - 'PAGER': '/bin/cat', 05:20:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:06 INFO - 'PWD': '/builds/slave/test', 05:20:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:20:06 INFO - 'SHELL': '/bin/bash', 05:20:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skAZRhLSwY/Listeners', 05:20:06 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:20:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:20:06 INFO - 'USER': 'cltbld', 05:20:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:20:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:06 INFO - 'XPC_FLAGS': '0x0', 05:20:06 INFO - 'XPC_SERVICE_NAME': '0', 05:20:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:06 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-o6eD_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:06 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-Q0vWb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:06 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-1xr1CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:07 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-63WuJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:07 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-N4z7tF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:07 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-IxDNK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:07 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-QqoFDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:07 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-QjAcIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:07 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-3xYY6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:07 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-FfuTR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:07 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-deZG02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:07 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-Rb6oUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:07 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-YUtDS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:08 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-IoXDTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:08 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-kRRksW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:08 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-nufrhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:08 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-eWIqi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:20:08 INFO - Running setup.py install for manifestparser 05:20:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:20:08 INFO - Running setup.py install for mozcrash 05:20:08 INFO - Running setup.py install for mozdebug 05:20:08 INFO - Running setup.py install for mozdevice 05:20:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:20:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:20:09 INFO - Running setup.py install for mozfile 05:20:09 INFO - Running setup.py install for mozhttpd 05:20:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:20:09 INFO - Running setup.py install for mozinfo 05:20:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:20:09 INFO - Running setup.py install for mozInstall 05:20:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:20:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:20:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:20:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:20:09 INFO - Running setup.py install for mozleak 05:20:09 INFO - Running setup.py install for mozlog 05:20:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:20:09 INFO - Running setup.py install for moznetwork 05:20:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:20:10 INFO - Running setup.py install for mozprocess 05:20:10 INFO - Running setup.py install for mozprofile 05:20:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:20:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:20:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:20:10 INFO - Running setup.py install for mozrunner 05:20:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:20:10 INFO - Running setup.py install for mozscreenshot 05:20:10 INFO - Running setup.py install for moztest 05:20:10 INFO - Running setup.py install for mozversion 05:20:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:20:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:20:11 INFO - Cleaning up... 05:20:11 INFO - Return code: 0 05:20:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017f5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcccb4a3940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101699d30>, '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 0x1014bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101690b20>, '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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 05:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:20:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZHDZ7T8x9/Render', 05:20:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:20:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:20:11 INFO - 'HOME': '/Users/cltbld', 05:20:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:20:11 INFO - 'LOGNAME': 'cltbld', 05:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:11 INFO - 'MOZ_NO_REMOTE': '1', 05:20:11 INFO - 'NO_EM_RESTART': '1', 05:20:11 INFO - 'PAGER': '/bin/cat', 05:20:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:11 INFO - 'PWD': '/builds/slave/test', 05:20:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:20:11 INFO - 'SHELL': '/bin/bash', 05:20:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skAZRhLSwY/Listeners', 05:20:11 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:20:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:20:11 INFO - 'USER': 'cltbld', 05:20:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:20:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:11 INFO - 'XPC_FLAGS': '0x0', 05:20:11 INFO - 'XPC_SERVICE_NAME': '0', 05:20:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:11 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-ZzNZog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:11 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-iiJqxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:11 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-M8ki8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:11 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)) 05:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:11 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-xQzyom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:11 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)) 05:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:11 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-M_FVCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:11 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)) 05:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:11 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-_D28ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:11 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)) 05:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:11 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-n9_v_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:12 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-4EBQkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:12 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-0Wrnz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:12 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-xXuMzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:12 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-E3hflW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:12 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)) 05:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:12 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-ntzBmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:12 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)) 05:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:12 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-BEaACC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:12 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)) 05:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:12 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-vHcKIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:12 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)) 05:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:12 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-WyoG1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:12 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)) 05:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:12 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-wmgMS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:13 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-xOo2bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:20:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:16 INFO - Downloading blessings-1.6.tar.gz 05:20:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:20:16 INFO - Installing collected packages: blessings 05:20:16 INFO - Running setup.py install for blessings 05:20:16 INFO - Successfully installed blessings 05:20:16 INFO - Cleaning up... 05:20:16 INFO - Return code: 0 05:20:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:20:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:16 INFO - Reading from file tmpfile_stdout 05:20:16 INFO - Current package versions: 05:20:16 INFO - blessings == 1.6 05:20:16 INFO - blobuploader == 1.2.4 05:20:16 INFO - docopt == 0.6.1 05:20:16 INFO - manifestparser == 1.1 05:20:16 INFO - mozInstall == 1.12 05:20:16 INFO - mozcrash == 0.16 05:20:16 INFO - mozdebug == 0.1 05:20:16 INFO - mozdevice == 0.48 05:20:16 INFO - mozfile == 1.2 05:20:16 INFO - mozhttpd == 0.7 05:20:16 INFO - mozinfo == 0.9 05:20:16 INFO - mozleak == 0.1 05:20:16 INFO - mozlog == 3.1 05:20:16 INFO - moznetwork == 0.27 05:20:16 INFO - mozprocess == 0.22 05:20:16 INFO - mozprofile == 0.28 05:20:16 INFO - mozrunner == 6.11 05:20:16 INFO - mozscreenshot == 0.1 05:20:16 INFO - mozsystemmonitor == 0.0 05:20:16 INFO - moztest == 0.7 05:20:16 INFO - mozversion == 1.4 05:20:16 INFO - psutil == 3.1.1 05:20:16 INFO - requests == 1.2.3 05:20:16 INFO - wsgiref == 0.1.2 05:20:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017f5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcccb4a3940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101699d30>, '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 0x1014bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101690b20>, '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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 05:20:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:20:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:20:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZHDZ7T8x9/Render', 05:20:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:20:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:20:16 INFO - 'HOME': '/Users/cltbld', 05:20:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:20:16 INFO - 'LOGNAME': 'cltbld', 05:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:16 INFO - 'MOZ_NO_REMOTE': '1', 05:20:16 INFO - 'NO_EM_RESTART': '1', 05:20:16 INFO - 'PAGER': '/bin/cat', 05:20:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:16 INFO - 'PWD': '/builds/slave/test', 05:20:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:20:16 INFO - 'SHELL': '/bin/bash', 05:20:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skAZRhLSwY/Listeners', 05:20:16 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:20:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:20:16 INFO - 'USER': 'cltbld', 05:20:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:20:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:16 INFO - 'XPC_FLAGS': '0x0', 05:20:16 INFO - 'XPC_SERVICE_NAME': '0', 05:20:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:20:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:20:16 INFO - Cleaning up... 05:20:16 INFO - Return code: 0 05:20:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017f5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcccb4a3940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101699d30>, '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 0x1014bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101690b20>, '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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 05:20:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:20:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:20:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZHDZ7T8x9/Render', 05:20:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:20:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:20:16 INFO - 'HOME': '/Users/cltbld', 05:20:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:20:16 INFO - 'LOGNAME': 'cltbld', 05:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:16 INFO - 'MOZ_NO_REMOTE': '1', 05:20:16 INFO - 'NO_EM_RESTART': '1', 05:20:16 INFO - 'PAGER': '/bin/cat', 05:20:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:16 INFO - 'PWD': '/builds/slave/test', 05:20:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:20:16 INFO - 'SHELL': '/bin/bash', 05:20:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skAZRhLSwY/Listeners', 05:20:16 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:20:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:20:16 INFO - 'USER': 'cltbld', 05:20:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:20:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:16 INFO - 'XPC_FLAGS': '0x0', 05:20:16 INFO - 'XPC_SERVICE_NAME': '0', 05:20:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:17 INFO - Downloading/unpacking jsonschema 05:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:20:19 INFO - Downloading/unpacking functools32 (from jsonschema) 05:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:19 INFO - Downloading functools32-3.2.3-2.tar.gz 05:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:20:20 INFO - warning: no files found matching '*.txt' 05:20:20 INFO - no previously-included directories found matching 'build' 05:20:20 INFO - no previously-included directories found matching 'dist' 05:20:20 INFO - no previously-included directories found matching '.git*' 05:20:20 INFO - Installing collected packages: jsonschema, functools32 05:20:20 INFO - Running setup.py install for functools32 05:20:20 INFO - warning: no files found matching '*.txt' 05:20:20 INFO - no previously-included directories found matching 'build' 05:20:20 INFO - no previously-included directories found matching 'dist' 05:20:20 INFO - no previously-included directories found matching '.git*' 05:20:20 INFO - Successfully installed jsonschema functools32 05:20:20 INFO - Cleaning up... 05:20:20 INFO - Return code: 0 05:20:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017f5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcccb4a3940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101699d30>, '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 0x1014bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101690b20>, '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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 05:20:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:20:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZHDZ7T8x9/Render', 05:20:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:20:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:20:20 INFO - 'HOME': '/Users/cltbld', 05:20:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:20:20 INFO - 'LOGNAME': 'cltbld', 05:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:20 INFO - 'MOZ_NO_REMOTE': '1', 05:20:20 INFO - 'NO_EM_RESTART': '1', 05:20:20 INFO - 'PAGER': '/bin/cat', 05:20:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:20 INFO - 'PWD': '/builds/slave/test', 05:20:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:20:20 INFO - 'SHELL': '/bin/bash', 05:20:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skAZRhLSwY/Listeners', 05:20:20 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:20:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:20:20 INFO - 'USER': 'cltbld', 05:20:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:20:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:20 INFO - 'XPC_FLAGS': '0x0', 05:20:20 INFO - 'XPC_SERVICE_NAME': '0', 05:20:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:20 INFO - Downloading/unpacking flake8 05:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:20:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:20:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:20:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:20:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:20:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:20:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:20:24 INFO - no previously-included directories found matching 'docs/_build' 05:20:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:20:24 INFO - Running setup.py install for pep8 05:20:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:20:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:20:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:20:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:20:24 INFO - no previously-included directories found matching 'docs/_build' 05:20:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:20:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:20:24 INFO - Cleaning up... 05:20:24 INFO - Return code: 0 05:20:24 INFO - Running post-action listener: _resource_record_post_action 05:20:24 INFO - Running post-action listener: _start_resource_monitoring 05:20:24 INFO - Starting resource monitoring. 05:20:24 INFO - ##### 05:20:24 INFO - ##### Running install step. 05:20:24 INFO - ##### 05:20:24 INFO - Running pre-action listener: _resource_record_pre_action 05:20:24 INFO - Running main action method: install 05:20:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:24 INFO - Reading from file tmpfile_stdout 05:20:24 INFO - Detecting whether we're running mozinstall >=1.0... 05:20:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:20:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:20:24 INFO - Reading from file tmpfile_stdout 05:20:24 INFO - Output received: 05:20:24 INFO - Usage: mozinstall [options] installer 05:20:24 INFO - Options: 05:20:24 INFO - -h, --help show this help message and exit 05:20:24 INFO - -d DEST, --destination=DEST 05:20:24 INFO - Directory to install application into. [default: 05:20:24 INFO - "/builds/slave/test"] 05:20:24 INFO - --app=APP Application being installed. [default: firefox] 05:20:24 INFO - mkdir: /builds/slave/test/build/application 05:20:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:20:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:20:58 INFO - Reading from file tmpfile_stdout 05:20:58 INFO - Output received: 05:20:58 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:20:58 INFO - Running post-action listener: _resource_record_post_action 05:20:58 INFO - ##### 05:20:58 INFO - ##### Running run-tests step. 05:20:58 INFO - ##### 05:20:58 INFO - Running pre-action listener: _resource_record_pre_action 05:20:58 INFO - Running main action method: run_tests 05:20:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:20:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:20:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:20:58 INFO - 2016-02-16 05:20:58.987 screenresolution[2939:82252] starting screenresolution argv=screenresolution get 05:20:58 INFO - 2016-02-16 05:20:58.989 screenresolution[2939:82252] Display 0: 1600x1200x32@60 05:20:58 INFO - 2016-02-16 05:20:58.995 screenresolution[2940:82254] starting screenresolution argv=screenresolution list 05:20:58 INFO - Available Modes on Display 0 05:20:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:20:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:20:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:20:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:20:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:20:59 INFO - Intel Iris: 05:20:59 INFO - Chipset Model: Intel Iris 05:20:59 INFO - Type: GPU 05:20:59 INFO - Bus: Built-In 05:20:59 INFO - VRAM (Dynamic, Max): 1536 MB 05:20:59 INFO - Vendor: Intel (0x8086) 05:20:59 INFO - Device ID: 0x0a2e 05:20:59 INFO - Revision ID: 0x0009 05:20:59 INFO - Displays: 05:20:59 INFO - Display: 05:20:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:20:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:20:59 INFO - Display Serial Number: 1600x1200 60 05:20:59 INFO - Main Display: Yes 05:20:59 INFO - Mirror: Off 05:20:59 INFO - Online: Yes 05:20:59 INFO - Rotation: Supported 05:20:59 INFO - Return code: 0 05:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:20:59 INFO - Python 2.7.3 05:20:59 INFO - Return code: 0 05:20:59 INFO - grabbing minidump binary from tooltool 05:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:59 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101699d30>, '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 0x1014bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101690b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:20:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:20:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:20:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:20:59 INFO - Return code: 0 05:20:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:20:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:20:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:20:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:20:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:21:00 INFO - Return code: 0 05:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0175', '--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 05:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0175 --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 05:21:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZHDZ7T8x9/Render', 05:21:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:00 INFO - 'HOME': '/Users/cltbld', 05:21:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:00 INFO - 'LOGNAME': 'cltbld', 05:21:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:21:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:00 INFO - 'MOZ_NO_REMOTE': '1', 05:21:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:21:00 INFO - 'NO_EM_RESTART': '1', 05:21:00 INFO - 'PAGER': '/bin/cat', 05:21:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:00 INFO - 'PWD': '/builds/slave/test', 05:21:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:21:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:00 INFO - 'SHELL': '/bin/bash', 05:21:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skAZRhLSwY/Listeners', 05:21:00 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 05:21:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:00 INFO - 'USER': 'cltbld', 05:21:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:00 INFO - 'XPC_FLAGS': '0x0', 05:21:00 INFO - 'XPC_SERVICE_NAME': '0', 05:21:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0175', '--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 05:21:00 INFO - mozversion application_buildid: 20160216030245 05:21:00 INFO - mozversion application_changeset: 6ea654cad929c9bedd8a4161a182b6189fbeae6a 05:21:00 INFO - mozversion application_display_name: Nightly 05:21:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:21:00 INFO - mozversion application_name: Firefox 05:21:00 INFO - mozversion application_remotingname: firefox 05:21:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:21:00 INFO - mozversion application_vendor: Mozilla 05:21:00 INFO - mozversion application_version: 47.0a1 05:21:00 INFO - mozversion platform_buildid: 20160216030245 05:21:00 INFO - mozversion platform_changeset: 6ea654cad929c9bedd8a4161a182b6189fbeae6a 05:21:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:21:00 INFO - mozversion platform_version: 47.0a1 05:21:00 INFO - using testdate: 1455628860 05:21:00 INFO - actual date: 1455628860 05:21:00 INFO - starting webserver on 'localhost:59477' 05:21:00 INFO - SUITE-START | Running 2 tests 05:21:00 INFO - TEST-START | dromaeo_css 05:21:00 INFO - operating with platform_type : mac_ 05:21:00 INFO - Initialising browser for dromaeo_css test... 05:21:00 INFO - TEST-INFO | started process 2958 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmp6dGAKs/profile http://localhost:59477/getInfo.html) 05:21:04 INFO - PROCESS | 2958 | __metrics Screen width/height:1600/1200 05:21:04 INFO - PROCESS | 2958 | colorDepth:24 05:21:04 INFO - PROCESS | 2958 | Browser inner width/height: 1024/689 05:21:04 INFO - PROCESS | 2958 | __metrics 05:21:04 INFO - TEST-INFO | 2958: exit 0 05:21:04 INFO - Browser initialized. 05:21:04 INFO - Running cycle 1/1 for dromaeo_css test... 05:21:04 INFO - TEST-INFO | started process 2963 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmp6dGAKs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:16 INFO - PROCESS | 2963 | RSS: Main: 256548864 05:21:16 INFO - PROCESS | 2963 | 05:22:06 INFO - PROCESS | 2963 | 1455628926632 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] 05:24:17 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:59477/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59477/tests/dromaeo/cssquery-ext.html) 05:24:19 INFO - PROCESS | 2963 | RSS: Main: 269639680 05:24:19 INFO - PROCESS | 2963 | 05:27:21 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:59477/tests/dromaeo/cssquery-ext.html (next: http://localhost:59477/tests/dromaeo/cssquery-jquery.html) 05:27:21 INFO - PROCESS | 2963 | RSS: Main: 282030080 05:27:21 INFO - PROCESS | 2963 | 05:30:23 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:59477/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59477/tests/dromaeo/cssquery-mootools.html) 05:30:24 INFO - PROCESS | 2963 | RSS: Main: 283570176 05:30:24 INFO - PROCESS | 2963 | 05:33:26 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:59477/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59477/tests/dromaeo/cssquery-prototype.html) 05:33:26 INFO - PROCESS | 2963 | RSS: Main: 286191616 05:33:26 INFO - PROCESS | 2963 | 05:36:29 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:59477/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59477/tests/dromaeo/cssquery-yui.html) 05:36:29 INFO - PROCESS | 2963 | RSS: Main: 288022528 05:36:29 INFO - PROCESS | 2963 | 05:39:32 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:59477/tests/dromaeo/cssquery-yui.html (next: http://localhost:59477/tests/dromaeo/cssquery-dojo.html) 05:39:32 INFO - PROCESS | 2963 | RSS: Main: 290238464 05:39:32 INFO - PROCESS | 2963 | 05:39:32 INFO - PROCESS | 2963 | __start_tp_report 05:39:32 INFO - PROCESS | 2963 | _x_x_mozilla_page_load 05:39:32 INFO - PROCESS | 2963 | _x_x_mozilla_page_load_details 05:39:32 INFO - PROCESS | 2963 | |i|pagename|runs| 05:39:32 INFO - PROCESS | 2963 | |0;dojo.html;3393.9999999999995;3418.8290585470704;3451.6893479586834;3472.9826350868243;3487.4420092785153;5501.284832971718;5555.722213889305;5557.360903496099;5567.554595632349;5579.246801681772;5448.548153331007;5514.91727624086;5560.2493663355435;5599.160125981105;5610.214569960199;4355.760433176182;5074.771635276403;5100.362454693163;5116.130257856174;5139.357580302462;5108.208227724708;5117.769700363474;5181.715005674687;5182.170852663575;5182.455842136559;4930.679505832128;4971.37857767779;5067.695938243717;5101.923471147936;5108.66793658411;5055.064813009568;5094.745262736848;5101.438841727444;5111.718855462948;5153.948460515385;4918.9916067206495;5066.82266120684;5080.364954380702;5093.516115968977;5096.847094587131;5315.681059136426;5470.480304371118;5510.118381059011;5513.7794488220425;5528;6003.459688628044;6050.062240352752;6067.484263837579;6078.452939235446;6083.513318934474;5917.289925208959;6059.39406059395;6111.302317925397;6120.112583675386;6165.445109940082;5645.463680950304;5649.265595472603;5650.7174641267775;5654.74553645087;5655.264815573949;6044;6216.285127210338;6242.500599951993;6247.156633854463;6248.125262463259;5820.272465941757;5839.970800146057;5866.73599688015;5886.499647529922;5904.911426328608;6100.877982440326;6103.511719062464;6104.20645316106;6110.205673262536;6124.540659450559;5969.671668058211;5977.790777322773;5987.520998320124;6002.249718785152;6005.369436209223;5932.822015339547;5970.0746384310505;6019.849503762441;6021.367756385516;6026.035834266497;4735.337052812609;4788.3056956741075;4801.735904525284;4803.231482962779;4825.30033145192;4182.853600123981;4283.357496375568;4361.12777444506;4362.672799540047;4394.384786129945;4047.777372244555;4476.686631935733;5047.570956468741;5089.592832573459;5480.123180291134;5277.997180535686;6091.634501929899;6101.084837274356;6143.877122457615;6148.723307451086;5303.071962406563;5439.401665816757;5488;5498.862528436821;5508.228847961289;4336.934945975813;5231.659942103751;5247.658902171346;5253.50091741284;5314.202869569518;5090.2364645303505;5490.533304669148;5868.706564671749;6257.217847769029;6282.089097080898;5991.490723288569;6096.817095487142;6099.329073801967;6118.877622447615;6146.354632763496;6136.720848337686;6176.289726681489;6192.195014648067;6193.256809182747;6199.628022318675;5570.24801651788;5996.1005849122985;5998.850028749316;6024.608400453956;6029.125776762433;5074.314967479343;5929;6064.02975523914;6125.204929265209;6152.077188421773;5889.52883769306;5902.38025007368;5905.055191169392;5906.675132867734;5949.107633854784;5676;5843.853903652443;5896.986824821972;5949.0481522956115;5957.225560677084;5376;5502.761878577288;5618.325800903917;5649.2373529574625;5709.143628455765;5781.971090144522;5802.274715660543;5813.302403711582;5831.096180092092;5836.9416305838095;5687.914681279867;5718.771249149988;5720.628159169641;5723.771049157987;5744.827655170351 05:39:32 INFO - PROCESS | 2963 | |1;ext.html;463.5086807983538;498.18795363557405;559.7621011070294;566.7223060700256;598.757503211199;25436.999999999978;37639.05902352442;37671.68149114785;37677.623223767754;37774.62225377745;39267.60732392675;39814.0046498837;39898.800505997504;40014.799556013364;40063.19873602526;9392.8591071134;9572.521373931311;9667.178289845371;9677.612895484172;9679.806403871919;9397.530123493832;9584.137427631511;9664.081912218327;9678.225741940663;9696.660616878411;9495.620175192984;9532.332736708433;9551.80896382072;9555.952220238889;9565.760855978586;9569.234461243153;9602.423854568713;9701.417914925127;9745.415275083518;9821.410715357102;8194.22154895284;9691.854622180674;9745.269104817096;9745.415275083447;9748.122668959828;38190.80904595487;38463.8076809617;38595.61404385948;38616;38966.610333896584;3138.73320767735;3178.8728450861936;3185.2036990752313;3192.201949512622;3307.1732066983254;21695;28855;29288.267793305124;29429;30044.54933176004;2540.212534114412;2778.610994460777;2797.6642802863785;2842.403095349979;2857.27139579408;479542;481044;481890;482013.1798682003;482947;55264.723676382164;62901.68549157225;63296.683516582125;63311.6834415825;64282.357176427635;55721.721391392784;56718.29845104653;60937.39062609317;61307.38692613106;61570.69214653898;14362.138271703523;14991;15613.141277229633;16092.195390230441;16328.510144695678;9864.704058878246;12285.57000504978;12402.317872517098;12404.875951240552;12429.875701242872;19486.512837179183;19702.01489925498;19953.401397957794;20383.388498345073;20409.79590204079;8175.63209655567;8337.458065225741;8769.38614296993;8945.239654629298;8971.102889711106;1031.2111234905303;1035.49260862177;1050.847627094067;1154.1452637940185;1161.9360935148648;29175.124746257647;29668.846569877573;29881.701182988327;29967.70032299649;30241.848790755907;1058.9932078710954;1072.0191025211843;1105.8562386889653;1125.2685754259796;1136.7044568412273;12210.75578488443;12562.623121306375;14144.36350364236;14804.963652544218;15326.923365383325;526718;544776;545184;546658;548414;56941.71529142328;57582.848343033744;57649;58081.128783068285;58302.7084864573;1419.2194293138732;1436.727021865842;1443.501991812844;1450.7461194290956;1553.9766903496457;29029.27426814262;29154.562681559368;29166;29748.10755677333;29748.55377169301;50392.49607503878;50444;50577.988440231726;50605.24092138547;50659.49340506548;490807;496608;498379;499698;506845.4657726688;30760;32759.34481310313;33698.15754606154;33745.83127084447;33782.81760138383;40961;41878.79060604677;42277.57722422737;42571.574284258;43119.56880431281;34542;35147.648523514436;35712.28575428529;35782.46326305055;36000.27999440049;34877.82561087178;35511.82244088763;35728.28543429169;35803;36073.458898117075;35537.28925421425;36381.63618363783;36496.63503364933;36648.81675591605;36652.45021324736;31275.68724312728;32732.018039458853;32843;32985.67014329826;33085.83457082699;22714.894595094076;24423;24431.14490992807;24813;24989.37526561778 05:39:32 INFO - PROCESS | 2963 | |2;jquery.html;361.93847046002185;361.96380361963793;362.472602363561;371.12784955354937;372.1700607644952;15216.163111028889;18894.433167004994;19194.424167274985;19335.903320483412;19859.404217873453;11608;13516.594502164926;17972.101394930265;19207.519812004706;19324.130414131363;3599.064243296749;4993.201087825949;5280.709560974145;5305.1776974569;5581.609287349887;5697.74360153792;5745.798897038604;5761.884762304772;5764.855878603047;5791.971040144794;5716.742316690322;6275.152854364671;6285.214348206474;6304.653244071575;6307.653079080649;5711.228984087136;5719.199312096268;5769.3653698093385;6244.625322480643;6382.648954307511;5445.101558242885;5456.399796022434;5480.177973303997;5489.313835770528;5493.807716729895;22098.116075356967;22975.540489190123;23112.537749244922;23318;23335.94988225534;2046.4986078410736;2119.237074653139;2143.10335353212;2191.6274233380364;2221.4782873731547;8017.318527925133;9245.72262832116;9752.756181095458;9804.607815687365;9907;1534.6240171158026;1668.2576253567167;1705.7441383792407;1723.7155869281553;1728.7839020122485;75025.62384692702;88073;95703.60740981462;96475.51762241144;102397.97602024033;11233.98894099535;11306.773864522827;11339.886601134049;11401.372924489067;11458.77082458363;13406.061575689802;13510.594682159552;13528.932355338357;13554.118982266122;13572.457101716018;6858.451323894076;8393;8395.748127556182;8500.97988241415;8554.18735220153;6864.4165245954655;8413;8449.070602233749;8467.237948584658;8557.44376615518;4108.096218831853;4263.424437700933;4297.312430011246;4419;4423.336499525032;1688.6285017296175;1841.5488205389497;1880.5110671225307;1881.8494520438333;1922.3367938061347;390.7635880292439;391.5555844116948;898.5911410308294;900.819836032783;928.1831987850783;11190.048845848194;11666.416679166177;11707.356095414834;11721.35532545701;11804.232724873027;433.4040694045687;445.4721155430825;450.682269000354;455.8632410276904;465.7182404645209;5962.612430192024;6140.539459540552;6146.078088286793;6156.722947467285;6198.287196972406;310406;701809;702457;719491;721185.3644390677;101429;112204.43897780622;112887;112944;114012.84702450584;481.46557321373245;485.28420579645444;490.60996507776406;491.34405568566365;492.5640807885048;10894.891051089704;10976.890231097907;11091;11116.777664446827;11159.38623375722;45729;47644;48062.03875922392;48313.27530087122;48804.755976219894;69846.30153698398;73732.26267737254;74198.25801742129;74221.88667170105;74568.25431745613;7288.016117824026;7550.3582195514;7667.808304792425;7750.6899724012665;7792.4545281832;11492.48283827213;11772.52909883595;11956.34240116802;12014.519419223483;12147.453364598437;9135.862962055442;10464.843027354747;10564.630237941636;10625.574977000833;10786.676399708022;9462.195713364441;9984.850227246452;10371.325863818827;10599.682009539727;10654.307470014424;9159.76343193687;9617.653528505874;10047.34692245031;10900.890991089987;11059.391733454737;7625.351845093229;7644.235576442311;7709.036370453693;7723.652435640297;7768.728094516665;5680.857978550404;9128.634854605742;9700.902990970282;10762.46187690628;10895 05:39:32 INFO - PROCESS | 2963 | |3;mootools.html;1503.4963287298754;1515.9393624255026;1731.9653606927861;1852.0369407907897;1873.7470441490395;8036.397270204729;8698.56507174642;8813.250873675737;9024.142706442886;9037.457752534845;8779.122087791233;8823.558822058903;8920.95539522303;8939.195472407482;8955.731328060168;2502.6120951252583;2509.29739672891;2519.4709111086695;2533.936651583707;2536.2771610091127;2480.8635525046116;2529.519391315653;2533.100749234023;2543.9618405723836;2555.744425557448;2217.1796435318956;2450.2281781238853;2500.1499490173337;2523.7980961523035;2535.847849129049;2376.346504711201;2386.4869053153657;2386.653935179398;2425.514897020594;2431.942105184242;2509.962350564743;2523.8864251108744;2525.2802951159015;2533.74662533747;2534.4931013797313;8793.42842715228;8810.295176385938;8840.204381605621;8845.292376609856;8867.733967980907;5410.161424979135;5553.4724201200825;5571.4428557143965;5612.887742245132;5623.49388555028;3648.799316037617;3723.5345581802276;3783.224438990028;3792.4500947362753;3803.67668748154;1051.1328154272678;1074.554060065072;1077.1113831089383;1102.3496137279044;1103.5971870267374;9978.30151889368;12053.975412089896;12125.029997600172;12135.878641213563;12146.392680366034;4862.270659401118;5001.72490513018;5024.145895197825;5048.798048078036;5074.213496907912;10315.484225788681;10366.118879895143;10372.636957706443;10399.584016639401;10413.895861041445;5583.581231407661;5606.6916319602815;5609.242752228479;5627.8874422512135;5628.099504079328;4982.227754698028;5034;5068.518490743373;5117.590592752571;5124.359455068116;4078.1843631273864;4098.221337945781;4099.651529620016;4127.071408932966;4134.338505839051;1228.950841966329;1340.3298350824587;1341.3159288762606;1348.3190988550916;1354.5462270139615;1085.766560189563;1087.8150714378417;1103.823388257875;1203.7661397068075;1213.902887768994;7778.844423111506;8081.393895457864;8144.185581441809;8214.8357032859;8306.8338633227;1160.4371879638368;1161.5992482593492;1169.4036041618665;1175.048210949134;1181.0669571038954;6172.69136543171;6227.06594010893;6268.561200715997;6275.717592708339;6303.3066362700065;10466.372017678812;10676.733081673021;10719;10743.033127018449;10837.945810270898;10385.84421233682;10493.9475302623;10618.840717389245;10664.680059598224;10708.357498550113;8287.751367458986;8407.369447291478;8411.327093832479;8472.406931514857;8493.702720404879;8076.515409075474;8254.587270636564;8294.58527073632;8319.500829950222;8338.416310858182;7363.631818409165;9426.905730942603;9762.219022478326;9816.644005438786;9819.36174148678;9094.27245820346;9505.572249248939;9557.713268601952;9864.950675246579;9953.502324883582;6311.936880631319;7559.470837041575;7640.770776876702;7707.306342429209;7753.728619498291;6811.4550835934;8197.877031844408;8283.95858020706;8290.544020078954;8332.958335208285;7408.888866667112;7775.57234352116;7885.605719713876;8033.558154301336;8058.758237252891;7658.157602663591;7697.769066928001;7702.845943080995;7778.455508114378;7809.648565814666;7803.648835802516;7816.765497035098;7849.254320839511;7854.2145785421;7876.330511906552;6215.471684906834;7056.470764692566;7062.364387205176;7091.716331346688;7176.820579485555;6036.547258955508;7215.891761623685;7253.601051942193;7274.527155734861;7359.448041397024 05:39:32 INFO - PROCESS | 2963 | |4;prototype.html;290.5569007263923;327.11841586923254;330.1498640999427;330.5240453746606;331.3538599730525;6692.598444093358;6806.353396427331;6846.144231971004;6935.445164386843;6935.44516438685;6846.965765171167;6877.89683154753;6880.036794848726;6894.5518541294905;6917.4466042716585;5101.872453188681;5105.821296254632;5122.564582010534;5125.820596279131;5139.408967968694;3846.307664620367;5094.79620815167;5101.795928162887;5122.871928201787;5129.512696293846;4909.656324057318;4919.483454237307;4923.990581930713;4927.6550641455115;4931.235658472942;4184.895377615553;4904.48502907195;4906.264060390934;4936.259561065833;4940.728259945701;3955.129871428281;4047.2107938951917;4159.625633692982;4168.541460439349;4195.91608167835;5778.757567123047;6078.422549857801;6564;6584.703688334036;6617.636030018347;5843.561732870052;5844.298684157886;5863.9706801466145;5877.5591830612875;5883.17635531026;7040.718371265194;7279.417646588313;7281.817954551126;7304.160021597531;7307.4884758066955;4633.884152896171;4670.1126785910565;4670.159371313162;4670.392848929651;4673.696209746356;6254.624722516618;7636.656350464187;7688;7715.189905059944;7723.729669461542;4081.0817566047995;4174.666026717855;4531.524189960072;4701.529847015339;4708.835190768306;4802.567768900746;4820.469748327681;4826.831060912921;4832.323474713543;4840;5803.636145505803;5806.622569532967;5818.040023396177;5832.096025116029;5834.94165058344;7319.377852882458;7319.377852882564;7330.560166390033;7344.045274114331;7375.151857536344;1501.0843385534815;1502.8722558582642;1669.8497135257885;1673.305578185064;1678.1106013812698;930.9898759845508;1043.8121138195197;1062.8246339354075;1068.7114479090758;1071.8660167479065;5472;5862.355140934494;6456.418922297016;6820.897686534706;6826.771181187434;7545.547267163988;7573.2048134946135;7599;7602.961985190039;7606.315431611181;5504.9449505504435;6168.845778855564;6795.898061529081;6827.249002609709;6838.14523184602;3205.8557364918634;3898.3762597984187;4003.399490076512;4015.2772500949527;4092.4884389451317;6468.256150542654;7927.722529711433;7976.641051152712;7980.3615710743;8064.959675201704;6441.806745797634;7936.642851071716;7953.2842044216295;7954.920450795534;7961.840763184704;7730.994970653892;8057.879131813028;8073.838523229385;8111.594420279081;8118.35053195743;6964.373206411245;7704.768856934301;7741.303282704584;7762.379009679099;7790.182030886902;7363.484556081023;7545.245475452631;7564.583947882699;7565.092188937363;7588.27911348421;8025.719099831478;8038.517688938682;8060.83878322442;8074.192580741878;8080.313173380094;4738.810447582058;4787.138315103315;4806.351142595705;4809.014152098742;4828.082664293773;7404.703811847466;7631.580263085583;7661.540307581563;7690.1925297845155;7696.307332339892;7389.408847292097;7399.852002960019;7413.332800048021;7414.998975138503;7417.666205020895;7131;7404.888926666212;7418.480706350504;7422.220666830121;7434.959105725095;7233.782986510413;7236.710531578678;7261.273872612696;7267;7309.049823522908;6044.425779550936;6400.97584386496;6954.687039083152;7403.66683499233;7420.109586849612;5692.231548740867;7247.891281630885;7255.4921155518605;7266.200717920919;7288.12542494904 05:39:32 INFO - PROCESS | 2963 | |5;yui.html;577.968326537131;654.9476041916647;678.5860625018738;714.1895295426093;725.4414101142121;13733.65665858354;14633.414663413463;14833.035852669569;14845.257737113156;14871.182084985336;12470.37648117595;13349.733005339887;13364.866351336485;13373.331333433314;13394.330283485835;680.2585182151454;827.3298628111219;832.8584140696096;856.297835774665;860.8493513635088;832.3216578488513;838.5010918503481;846.5047946951041;849.7110982266029;849.800296930221;903.7740564858785;903.9728808135734;904;904.398574947659;905.2441211588332;899.1772528136747;901.1079031758577;901.1394118616738;901.5717534171249;905.5698543191965;663.4327649859397;670.4803777072759;673.1182151381705;673.2728653054689;674.3122015544118;14172.29138543079;14195.78706319406;14308.356123974447;14422.567322980327;14680.632984175481;12837;12855.485780568766;12928;13211.075224734272;13385.26381049042;10033.59865605375;10144.239182061376;10159.441230732307;10174.949125254401;10262.179025678002;2918.897838575661;3542.3446662367546;3564.376234159012;3615.2950174715943;3646.6682216785102;79578;80465;80889.59555202187;81373.59313203456;82611.17388826095;9557.426554406758;9664.468454235084;9781.951090244504;9790.510474476248;9851.451086768247;21835.781642183694;22068.558628827333;22093;22096.33710988673;22178.889105554368;7515.887261691079;7594;7748.690052397841;7795.883061754078;7944.126146123922;4029.174019326031;4032.2540330039037;4038.7980600970423;4088.8773336799945;4103.138340948434;3631.1648320886343;3650.178709790276;3658.762180458262;3671.100580357776;3677.8344974476213;682.5631595778706;701.421327404893;713.728783062433;716.5056111283197;724.0298000679115;432.7490055767647;522.344457705577;567.4268988321742;591.9289685237799;614.9292831324454;7386.113666360071;7802.804929876685;8387.454815436977;8508.149185081566;8608.397412181212;522.1567169022078;604.5496105401504;609.2719200555382;609.3479976425272;623.9313675495691;3865.4974853268895;3885.6502914737243;3887.1059656279213;4235;4313.84901528445;80082.59958700169;96028.51985740027;96306.51846740721;97447.53828692576;101527.98472015333;83361;83586;84094;84202;84264;65974;66633;68316;69474.95787563191;71415.6429217861;7224.988501609884;7489.962550187214;8665.17680820321;8762.342824288076;8795.560221988748;50082.74958625183;50109.498905010485;50608.746956264986;50753.49246507488;51402.97194056023;38163.42754858624;60032.39967600268;68698;70657;72178;10836.783264334512;11121.332720036824;11240.494177762184;11321.886781132413;11683.88316116828;11547.422628868691;11747.177697561088;11797.941010294893;11959.581414650445;12251.87748122543;11532.711682208012;11559;11654.941725291319;11659.125565582446;11659.825102623638;9379.577918993526;9593.376430531993;11114.666560003212;11471.827922581335;11591.6522504325;8135.7152499662225;10562.994673701904;10700.411477368509;10798;11018.11855051578;8112;8674.915635545556;8899.688510902088;9037.231835294073;9182.026501942704;9519.904800951901;9600.039996000623;9642.132208101304;9656.5638495063;9700.5149742514 05:39:32 INFO - PROCESS | 2963 | __end_tp_report 05:39:32 INFO - PROCESS | 2963 | __start_cc_report 05:39:32 INFO - PROCESS | 2963 | _x_x_mozilla_cycle_collect,358 05:39:32 INFO - PROCESS | 2963 | __end_cc_report 05:39:32 INFO - PROCESS | 2963 | __startTimestamp1455629972420__endTimestamp 05:39:32 INFO - PROCESS | 2963 | 05:39:32 INFO - PROCESS | 2963 | ------- Summary: start ------- 05:39:32 INFO - PROCESS | 2963 | Number of tests: 6 05:39:32 INFO - PROCESS | 2963 | 05:39:32 INFO - PROCESS | 2963 | [#0] dojo.html Cycles:165 Average:5527.37 Median:5654.75 stddev:625.23 (11.1%) stddev-sans-first:604.34 05:39:32 INFO - PROCESS | 2963 | Values: 3394.0 3418.8 3451.7 3473.0 3487.4 5501.3 5555.7 5557.4 5567.6 5579.2 5448.5 5514.9 5560.2 5599.2 5610.2 4355.8 5074.8 5100.4 5116.1 5139.4 5108.2 5117.8 5181.7 5182.2 5182.5 4930.7 4971.4 5067.7 5101.9 5108.7 5055.1 5094.7 5101.4 5111.7 5153.9 4919.0 5066.8 5080.4 5093.5 5096.8 5315.7 5470.5 5510.1 5513.8 5528.0 6003.5 6050.1 6067.5 6078.5 6083.5 5917.3 6059.4 6111.3 6120.1 6165.4 5645.5 5649.3 5650.7 5654.7 5655.3 6044.0 6216.3 6242.5 6247.2 6248.1 5820.3 5840.0 5866.7 5886.5 5904.9 6100.9 6103.5 6104.2 6110.2 6124.5 5969.7 5977.8 5987.5 6002.2 6005.4 5932.8 5970.1 6019.8 6021.4 6026.0 4735.3 4788.3 4801.7 4803.2 4825.3 4182.9 4283.4 4361.1 4362.7 4394.4 4047.8 4476.7 5047.6 5089.6 5480.1 5278.0 6091.6 6101.1 6143.9 6148.7 5303.1 5439.4 5488.0 5498.9 5508.2 4336.9 5231.7 5247.7 5253.5 5314.2 5090.2 5490.5 5868.7 6257.2 6282.1 5991.5 6096.8 6099.3 6118.9 6146.4 6136.7 6176.3 6192.2 6193.3 6199.6 5570.2 5996.1 5998.9 6024.6 6029.1 5074.3 5929.0 6064.0 6125.2 6152.1 5889.5 5902.4 5905.1 5906.7 5949.1 5676.0 5843.9 5897.0 5949.0 5957.2 5376.0 5502.8 5618.3 5649.2 5709.1 5782.0 5802.3 5813.3 5831.1 5836.9 5687.9 5718.8 5720.6 5723.8 5744.8 05:39:32 INFO - PROCESS | 2963 | 05:39:32 INFO - PROCESS | 2963 | [#1] ext.html Cycles:180 Average:64427.66 Median:37655.37 stddev:135273.38 (359.2%) stddev-sans-first:135567.61 05:39:32 INFO - PROCESS | 2963 | Values: 463.5 498.2 559.8 566.7 598.8 25437.0 37639.1 37671.7 37677.6 37774.6 39267.6 39814.0 39898.8 40014.8 40063.2 9392.9 9572.5 9667.2 9677.6 9679.8 9397.5 9584.1 9664.1 9678.2 9696.7 9495.6 9532.3 9551.8 9556.0 9565.8 9569.2 9602.4 9701.4 9745.4 9821.4 8194.2 9691.9 9745.3 9745.4 9748.1 38190.8 38463.8 38595.6 38616.0 38966.6 3138.7 3178.9 3185.2 3192.2 3307.2 21695.0 28855.0 29288.3 29429.0 30044.5 2540.2 2778.6 2797.7 2842.4 2857.3 479542.0 481044.0 481890.0 482013.2 482947.0 55264.7 62901.7 63296.7 63311.7 64282.4 55721.7 56718.3 60937.4 61307.4 61570.7 14362.1 14991.0 15613.1 16092.2 16328.5 9864.7 12285.6 12402.3 12404.9 12429.9 19486.5 19702.0 19953.4 20383.4 20409.8 8175.6 8337.5 8769.4 8945.2 8971.1 1031.2 1035.5 1050.8 1154.1 1161.9 29175.1 29668.8 29881.7 29967.7 30241.8 1059.0 1072.0 1105.9 1125.3 1136.7 12210.8 12562.6 14144.4 14805.0 15326.9 526718.0 544776.0 545184.0 546658.0 548414.0 56941.7 57582.8 57649.0 58081.1 58302.7 1419.2 1436.7 1443.5 1450.7 1554.0 29029.3 29154.6 29166.0 29748.1 29748.6 50392.5 50444.0 50578.0 50605.2 50659.5 490807.0 496608.0 498379.0 499698.0 506845.5 30760.0 32759.3 33698.2 33745.8 33782.8 40961.0 41878.8 42277.6 42571.6 43119.6 34542.0 35147.6 35712.3 35782.5 36000.3 34877.8 35511.8 35728.3 35803.0 36073.5 35537.3 36381.6 36496.6 36648.8 36652.5 31275.7 32732.0 32843.0 32985.7 33085.8 22714.9 24423.0 24431.1 24813.0 24989.4 05:39:32 INFO - PROCESS | 2963 | 05:39:32 INFO - PROCESS | 2963 | [#2] jquery.html Cycles:180 Average:33299.82 Median:23092.43 stddev:107709.99 (466.4%) stddev-sans-first:107983.75 05:39:32 INFO - PROCESS | 2963 | Values: 361.9 362.0 362.5 371.1 372.2 15216.2 18894.4 19194.4 19335.9 19859.4 11608.0 13516.6 17972.1 19207.5 19324.1 3599.1 4993.2 5280.7 5305.2 5581.6 5697.7 5745.8 5761.9 5764.9 5792.0 5716.7 6275.2 6285.2 6304.7 6307.7 5711.2 5719.2 5769.4 6244.6 6382.6 5445.1 5456.4 5480.2 5489.3 5493.8 22098.1 22975.5 23112.5 23318.0 23335.9 2046.5 2119.2 2143.1 2191.6 2221.5 8017.3 9245.7 9752.8 9804.6 9907.0 1534.6 1668.3 1705.7 1723.7 1728.8 75025.6 88073.0 95703.6 96475.5 102398.0 11234.0 11306.8 11339.9 11401.4 11458.8 13406.1 13510.6 13528.9 13554.1 13572.5 6858.5 8393.0 8395.7 8501.0 8554.2 6864.4 8413.0 8449.1 8467.2 8557.4 4108.1 4263.4 4297.3 4419.0 4423.3 1688.6 1841.5 1880.5 1881.8 1922.3 390.8 391.6 898.6 900.8 928.2 11190.0 11666.4 11707.4 11721.4 11804.2 433.4 445.5 450.7 455.9 465.7 5962.6 6140.5 6146.1 6156.7 6198.3 310406.0 701809.0 702457.0 719491.0 721185.4 101429.0 112204.4 112887.0 112944.0 114012.8 481.5 485.3 490.6 491.3 492.6 10894.9 10976.9 11091.0 11116.8 11159.4 45729.0 47644.0 48062.0 48313.3 48804.8 69846.3 73732.3 74198.3 74221.9 74568.3 7288.0 7550.4 7667.8 7750.7 7792.5 11492.5 11772.5 11956.3 12014.5 12147.5 9135.9 10464.8 10564.6 10625.6 10786.7 9462.2 9984.9 10371.3 10599.7 10654.3 9159.8 9617.7 10047.3 10900.9 11059.4 7625.4 7644.2 7709.0 7723.7 7768.7 5680.9 9128.6 9700.9 10762.5 10895.0 05:39:32 INFO - PROCESS | 2963 | 05:39:32 INFO - PROCESS | 2963 | [#3] mootools.html Cycles:180 Average:6118.59 Median:5562.46 stddev:3176.75 (57.1%) stddev-sans-first:3166.72 05:39:32 INFO - PROCESS | 2963 | Values: 1503.5 1515.9 1732.0 1852.0 1873.7 8036.4 8698.6 8813.3 9024.1 9037.5 8779.1 8823.6 8921.0 8939.2 8955.7 2502.6 2509.3 2519.5 2533.9 2536.3 2480.9 2529.5 2533.1 2544.0 2555.7 2217.2 2450.2 2500.1 2523.8 2535.8 2376.3 2386.5 2386.7 2425.5 2431.9 2510.0 2523.9 2525.3 2533.7 2534.5 8793.4 8810.3 8840.2 8845.3 8867.7 5410.2 5553.5 5571.4 5612.9 5623.5 3648.8 3723.5 3783.2 3792.5 3803.7 1051.1 1074.6 1077.1 1102.3 1103.6 9978.3 12054.0 12125.0 12135.9 12146.4 4862.3 5001.7 5024.1 5048.8 5074.2 10315.5 10366.1 10372.6 10399.6 10413.9 5583.6 5606.7 5609.2 5627.9 5628.1 4982.2 5034.0 5068.5 5117.6 5124.4 4078.2 4098.2 4099.7 4127.1 4134.3 1229.0 1340.3 1341.3 1348.3 1354.5 1085.8 1087.8 1103.8 1203.8 1213.9 7778.8 8081.4 8144.2 8214.8 8306.8 1160.4 1161.6 1169.4 1175.0 1181.1 6172.7 6227.1 6268.6 6275.7 6303.3 10466.4 10676.7 10719.0 10743.0 10837.9 10385.8 10493.9 10618.8 10664.7 10708.4 8287.8 8407.4 8411.3 8472.4 8493.7 8076.5 8254.6 8294.6 8319.5 8338.4 7363.6 9426.9 9762.2 9816.6 9819.4 9094.3 9505.6 9557.7 9865.0 9953.5 6311.9 7559.5 7640.8 7707.3 7753.7 6811.5 8197.9 8284.0 8290.5 8333.0 7408.9 7775.6 7885.6 8033.6 8058.8 7658.2 7697.8 7702.8 7778.5 7809.6 7803.6 7816.8 7849.3 7854.2 7876.3 6215.5 7056.5 7062.4 7091.7 7176.8 6036.5 7215.9 7253.6 7274.5 7359.4 05:39:32 INFO - PROCESS | 2963 | 05:39:32 INFO - PROCESS | 2963 | [#4] prototype.html Cycles:180 Average:5924.80 Median:6744.25 stddev:1958.37 (29.0%) stddev-sans-first:1917.67 05:39:32 INFO - PROCESS | 2963 | Values: 290.6 327.1 330.1 330.5 331.4 6692.6 6806.4 6846.1 6935.4 6935.4 6847.0 6877.9 6880.0 6894.6 6917.4 5101.9 5105.8 5122.6 5125.8 5139.4 3846.3 5094.8 5101.8 5122.9 5129.5 4909.7 4919.5 4924.0 4927.7 4931.2 4184.9 4904.5 4906.3 4936.3 4940.7 3955.1 4047.2 4159.6 4168.5 4195.9 5778.8 6078.4 6564.0 6584.7 6617.6 5843.6 5844.3 5864.0 5877.6 5883.2 7040.7 7279.4 7281.8 7304.2 7307.5 4633.9 4670.1 4670.2 4670.4 4673.7 6254.6 7636.7 7688.0 7715.2 7723.7 4081.1 4174.7 4531.5 4701.5 4708.8 4802.6 4820.5 4826.8 4832.3 4840.0 5803.6 5806.6 5818.0 5832.1 5834.9 7319.4 7319.4 7330.6 7344.0 7375.2 1501.1 1502.9 1669.8 1673.3 1678.1 931.0 1043.8 1062.8 1068.7 1071.9 5472.0 5862.4 6456.4 6820.9 6826.8 7545.5 7573.2 7599.0 7603.0 7606.3 5504.9 6168.8 6795.9 6827.2 6838.1 3205.9 3898.4 4003.4 4015.3 4092.5 6468.3 7927.7 7976.6 7980.4 8065.0 6441.8 7936.6 7953.3 7954.9 7961.8 7731.0 8057.9 8073.8 8111.6 8118.4 6964.4 7704.8 7741.3 7762.4 7790.2 7363.5 7545.2 7564.6 7565.1 7588.3 8025.7 8038.5 8060.8 8074.2 8080.3 4738.8 4787.1 4806.4 4809.0 4828.1 7404.7 7631.6 7661.5 7690.2 7696.3 7389.4 7399.9 7413.3 7415.0 7417.7 7131.0 7404.9 7418.5 7422.2 7435.0 7233.8 7236.7 7261.3 7267.0 7309.0 6044.4 6401.0 6954.7 7403.7 7420.1 5692.2 7247.9 7255.5 7266.2 7288.1 05:39:32 INFO - PROCESS | 2963 | 05:39:32 INFO - PROCESS | 2963 | [#5] yui.html Cycles:180 Average:18252.08 Median:639.44 stddev:26041.59 (4072.6%) stddev-sans-first:26080.82 05:39:32 INFO - PROCESS | 2963 | Values: 578.0 654.9 678.6 714.2 725.4 13733.7 14633.4 14833.0 14845.3 14871.2 12470.4 13349.7 13364.9 13373.3 13394.3 680.3 827.3 832.9 856.3 860.8 832.3 838.5 846.5 849.7 849.8 903.8 904.0 904.0 904.4 905.2 899.2 901.1 901.1 901.6 905.6 663.4 670.5 673.1 673.3 674.3 14172.3 14195.8 14308.4 14422.6 14680.6 12837.0 12855.5 12928.0 13211.1 13385.3 10033.6 10144.2 10159.4 10174.9 10262.2 2918.9 3542.3 3564.4 3615.3 3646.7 79578.0 80465.0 80889.6 81373.6 82611.2 9557.4 9664.5 9782.0 9790.5 9851.5 21835.8 22068.6 22093.0 22096.3 22178.9 7515.9 7594.0 7748.7 7795.9 7944.1 4029.2 4032.3 4038.8 4088.9 4103.1 3631.2 3650.2 3658.8 3671.1 3677.8 682.6 701.4 713.7 716.5 724.0 432.7 522.3 567.4 591.9 614.9 7386.1 7802.8 8387.5 8508.1 8608.4 522.2 604.5 609.3 609.3 623.9 3865.5 3885.7 3887.1 4235.0 4313.8 80082.6 96028.5 96306.5 97447.5 101528.0 83361.0 83586.0 84094.0 84202.0 84264.0 65974.0 66633.0 68316.0 69475.0 71415.6 7225.0 7490.0 8665.2 8762.3 8795.6 50082.7 50109.5 50608.7 50753.5 51403.0 38163.4 60032.4 68698.0 70657.0 72178.0 10836.8 11121.3 11240.5 11321.9 11683.9 11547.4 11747.2 11797.9 11959.6 12251.9 11532.7 11559.0 11654.9 11659.1 11659.8 9379.6 9593.4 11114.7 11471.8 11591.7 8135.7 10563.0 10700.4 10798.0 11018.1 8112.0 8674.9 8899.7 9037.2 9182.0 9519.9 9600.0 9642.1 9656.6 9700.5 05:39:32 INFO - PROCESS | 2963 | -------- Summary: end -------- 05:39:32 INFO - PROCESS | 2963 | 05:39:32 INFO - TEST-INFO | 2963: exit 0 05:39:32 INFO - TEST-OK | dromaeo_css | took 1112164ms 05:39:32 INFO - TEST-START | kraken 05:39:32 INFO - operating with platform_type : mac_ 05:39:32 INFO - Initialising browser for kraken test... 05:39:32 INFO - TEST-INFO | started process 2971 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpadaGv7/profile http://localhost:59477/getInfo.html) 05:39:35 INFO - PROCESS | 2971 | __metrics Screen width/height:1600/1200 05:39:35 INFO - PROCESS | 2971 | colorDepth:24 05:39:35 INFO - PROCESS | 2971 | Browser inner width/height: 1024/689 05:39:35 INFO - PROCESS | 2971 | __metrics 05:39:36 INFO - TEST-INFO | 2971: exit 0 05:39:36 INFO - Browser initialized. 05:39:36 INFO - Running cycle 1/1 for kraken test... 05:39:36 INFO - TEST-INFO | started process 2975 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpadaGv7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:48 INFO - PROCESS | 2975 | RSS: Main: 256126976 05:39:48 INFO - PROCESS | 2975 | 05:39:51 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59477/tests/kraken/driver.html?testName=audio-beat-detection) 05:39:52 INFO - PROCESS | 2975 | RSS: Main: 269213696 05:39:52 INFO - PROCESS | 2975 | 05:39:54 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59477/tests/kraken/driver.html?testName=audio-dft) 05:39:55 INFO - PROCESS | 2975 | RSS: Main: 277856256 05:39:55 INFO - PROCESS | 2975 | 05:39:58 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59477/tests/kraken/driver.html?testName=audio-fft) 05:39:59 INFO - PROCESS | 2975 | RSS: Main: 282394624 05:39:59 INFO - PROCESS | 2975 | 05:40:01 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59477/tests/kraken/driver.html?testName=audio-oscillator) 05:40:01 INFO - PROCESS | 2975 | RSS: Main: 284446720 05:40:01 INFO - PROCESS | 2975 | 05:40:03 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59477/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:40:04 INFO - PROCESS | 2975 | RSS: Main: 285212672 05:40:04 INFO - PROCESS | 2975 | 05:40:07 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59477/tests/kraken/driver.html?testName=imaging-darkroom) 05:40:07 INFO - PROCESS | 2975 | RSS: Main: 285016064 05:40:07 INFO - PROCESS | 2975 | 05:40:11 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59477/tests/kraken/driver.html?testName=imaging-desaturate) 05:40:11 INFO - PROCESS | 2975 | RSS: Main: 284901376 05:40:11 INFO - PROCESS | 2975 | 05:40:14 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59477/tests/kraken/driver.html?testName=json-parse-financial) 05:40:15 INFO - PROCESS | 2975 | RSS: Main: 285683712 05:40:15 INFO - PROCESS | 2975 | 05:40:16 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59477/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:40:17 INFO - PROCESS | 2975 | RSS: Main: 284545024 05:40:17 INFO - PROCESS | 2975 | 05:40:19 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:40:19 INFO - PROCESS | 2975 | RSS: Main: 284413952 05:40:19 INFO - PROCESS | 2975 | 05:40:21 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:40:22 INFO - PROCESS | 2975 | RSS: Main: 284475392 05:40:22 INFO - PROCESS | 2975 | 05:40:25 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:40:25 INFO - PROCESS | 2975 | RSS: Main: 284229632 05:40:25 INFO - PROCESS | 2975 | 05:40:28 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:40:28 INFO - PROCESS | 2975 | RSS: Main: 285786112 05:40:28 INFO - PROCESS | 2975 | 05:40:30 INFO - PROCESS | 2975 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59477/tests/kraken/driver.html?testName=ai-astar) 05:40:31 INFO - PROCESS | 2975 | RSS: Main: 285278208 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | __start_tp_report 05:40:31 INFO - PROCESS | 2975 | _x_x_mozilla_page_load 05:40:31 INFO - PROCESS | 2975 | _x_x_mozilla_page_load_details 05:40:31 INFO - PROCESS | 2975 | |i|pagename|runs| 05:40:31 INFO - PROCESS | 2975 | |0;ai-astar;114;109;114;114;116;124;116;124;171;166 05:40:31 INFO - PROCESS | 2975 | |1;audio-beat-detection;161;144;160;147;112;193;174;158;158;142 05:40:31 INFO - PROCESS | 2975 | |2;audio-dft;199;199;206;216;227;199;196;204;204;198 05:40:31 INFO - PROCESS | 2975 | |3;audio-fft;84;69;76;111;64;64;83;91;149;72 05:40:31 INFO - PROCESS | 2975 | |4;audio-oscillator;84;88;113;79;81;82;118;81;83;114 05:40:31 INFO - PROCESS | 2975 | |5;imaging-gaussian-blur;85;91;85;92;126;102;85;92;84;91 05:40:31 INFO - PROCESS | 2975 | |6;imaging-darkroom;152;130;94;96;95;119;156;104;95;96 05:40:31 INFO - PROCESS | 2975 | |7;imaging-desaturate;90;101;93;90;100;93;92;132;156;143 05:40:31 INFO - PROCESS | 2975 | |8;json-parse-financial;56;57;54;56;57;56;57;62;54;55 05:40:31 INFO - PROCESS | 2975 | |9;json-stringify-tinderbox;65;68;71;65;80;73;69;65;67;70 05:40:31 INFO - PROCESS | 2975 | |10;stanford-crypto-aes;86;84;86;84;87;83;86;85;87;86 05:40:31 INFO - PROCESS | 2975 | |11;stanford-crypto-ccm;131;134;115;152;141;130;142;125;140;136 05:40:31 INFO - PROCESS | 2975 | |12;stanford-crypto-pbkdf2;140;145;146;141;143;148;178;128;182;165 05:40:31 INFO - PROCESS | 2975 | |13;stanford-crypto-sha256-iterative;68;73;95;99;99;96;100;56;75;99 05:40:31 INFO - PROCESS | 2975 | __end_tp_report 05:40:31 INFO - PROCESS | 2975 | __start_cc_report 05:40:31 INFO - PROCESS | 2975 | _x_x_mozilla_cycle_collect,891 05:40:31 INFO - PROCESS | 2975 | __end_cc_report 05:40:31 INFO - PROCESS | 2975 | __startTimestamp1455630031102__endTimestamp 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | ------- Summary: start ------- 05:40:31 INFO - PROCESS | 2975 | Number of tests: 14 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | [#0] ai-astar Cycles:10 Average:126.80 Median:120.00 stddev:22.48 (18.7%) stddev-sans-first:23.36 05:40:31 INFO - PROCESS | 2975 | Values: 114.0 109.0 114.0 114.0 116.0 124.0 116.0 124.0 171.0 166.0 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | [#1] audio-beat-detection Cycles:10 Average:154.90 Median:159.00 stddev:21.31 (13.4%) stddev-sans-first:22.49 05:40:31 INFO - PROCESS | 2975 | Values: 161.0 144.0 160.0 147.0 112.0 193.0 174.0 158.0 158.0 142.0 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | [#2] audio-dft Cycles:10 Average:204.80 Median:204.00 stddev:9.69 (4.8%) stddev-sans-first:10.05 05:40:31 INFO - PROCESS | 2975 | Values: 199.0 199.0 206.0 216.0 227.0 199.0 196.0 204.0 204.0 198.0 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | [#3] audio-fft Cycles:10 Average:86.30 Median:74.00 stddev:26.21 (35.4%) stddev-sans-first:27.79 05:40:31 INFO - PROCESS | 2975 | Values: 84.0 69.0 76.0 111.0 64.0 64.0 83.0 91.0 149.0 72.0 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:81.50 stddev:15.89 (19.5%) stddev-sans-first:16.57 05:40:31 INFO - PROCESS | 2975 | Values: 84.0 88.0 113.0 79.0 81.0 82.0 118.0 81.0 83.0 114.0 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | [#5] imaging-gaussian-blur Cycles:10 Average:93.30 Median:88.00 stddev:12.70 (14.4%) stddev-sans-first:13.11 05:40:31 INFO - PROCESS | 2975 | Values: 85.0 91.0 85.0 92.0 126.0 102.0 85.0 92.0 84.0 91.0 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | [#6] imaging-darkroom Cycles:10 Average:113.70 Median:94.50 stddev:24.40 (25.8%) stddev-sans-first:21.59 05:40:31 INFO - PROCESS | 2975 | Values: 152.0 130.0 94.0 96.0 95.0 119.0 156.0 104.0 95.0 96.0 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | [#7] imaging-desaturate Cycles:10 Average:109.00 Median:90.00 stddev:24.86 (27.6%) stddev-sans-first:25.40 05:40:31 INFO - PROCESS | 2975 | Values: 90.0 101.0 93.0 90.0 100.0 93.0 92.0 132.0 156.0 143.0 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:2.27 (4.0%) stddev-sans-first:2.40 05:40:31 INFO - PROCESS | 2975 | Values: 56.0 57.0 54.0 56.0 57.0 56.0 57.0 62.0 54.0 55.0 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:4.64 (6.7%) stddev-sans-first:4.66 05:40:31 INFO - PROCESS | 2975 | Values: 65.0 68.0 71.0 65.0 80.0 73.0 69.0 65.0 67.0 70.0 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:86.00 stddev:1.35 (1.6%) stddev-sans-first:1.41 05:40:31 INFO - PROCESS | 2975 | Values: 86.0 84.0 86.0 84.0 87.0 83.0 86.0 85.0 87.0 86.0 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:138.00 stddev:10.22 (7.4%) stddev-sans-first:10.76 05:40:31 INFO - PROCESS | 2975 | Values: 131.0 134.0 115.0 152.0 141.0 130.0 142.0 125.0 140.0 136.0 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:147.00 stddev:17.53 (11.9%) stddev-sans-first:18.09 05:40:31 INFO - PROCESS | 2975 | Values: 140.0 145.0 146.0 141.0 143.0 148.0 178.0 128.0 182.0 165.0 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - PROCESS | 2975 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.00 Median:95.50 stddev:16.32 (17.1%) stddev-sans-first:15.96 05:40:31 INFO - PROCESS | 2975 | Values: 68.0 73.0 95.0 99.0 99.0 96.0 100.0 56.0 75.0 99.0 05:40:31 INFO - PROCESS | 2975 | -------- Summary: end -------- 05:40:31 INFO - PROCESS | 2975 | 05:40:31 INFO - TEST-INFO | 2975: exit 0 05:40:31 INFO - TEST-OK | kraken | took 58903ms 05:40:31 INFO - SUITE-END | took 1171s 05:40:32 INFO - Completed test suite (00:19:31) 05:40:32 INFO - Working with test: dromaeo_css 05:40:32 INFO - Generating results file: dromaeo_css 05:40:32 INFO - Working with test: kraken 05:40:32 INFO - Generating results file: kraken 05:40:32 INFO - javascript benchmark 05:40:32 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:40:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 05:40:32 INFO - process_Request line: dromaeo_css 7343.61 graph.html#tests=[[72,1,61]] 05:40:32 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:40:32 INFO - process_Request line: kraken 1564.40 graph.html#tests=[[232,1,61]] 05:40:32 INFO - RETURN: dromaeo_css: 7343.61 05:40:32 INFO - RETURN: kraken: 1564.40 05:40:32 INFO - javascript benchmark 05:40:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3393.9999999999995, 3418.8290585470704, 3451.6893479586834, 3472.9826350868243, 3487.4420092785153, 5501.284832971718, 5555.722213889305, 5557.360903496099, 5567.554595632349, 5579.246801681772, 5448.548153331007, 5514.91727624086, 5560.2493663355435, 5599.160125981105, 5610.214569960199, 4355.760433176182, 5074.771635276403, 5100.362454693163, 5116.130257856174, 5139.357580302462, 5108.208227724708, 5117.769700363474, 5181.715005674687, 5182.170852663575, 5182.455842136559, 4930.679505832128, 4971.37857767779, 5067.695938243717, 5101.923471147936, 5108.66793658411, 5055.064813009568, 5094.745262736848, 5101.438841727444, 5111.718855462948, 5153.948460515385, 4918.9916067206495, 5066.82266120684, 5080.364954380702, 5093.516115968977, 5096.847094587131, 5315.681059136426, 5470.480304371118, 5510.118381059011, 5513.7794488220425, 5528.0, 6003.459688628044, 6050.062240352752, 6067.484263837579, 6078.452939235446, 6083.513318934474, 5917.289925208959, 6059.39406059395, 6111.302317925397, 6120.112583675386, 6165.445109940082, 5645.463680950304, 5649.265595472603, 5650.7174641267775, 5654.74553645087, 5655.264815573949, 6044.0, 6216.285127210338, 6242.500599951993, 6247.156633854463, 6248.125262463259, 5820.272465941757, 5839.970800146057, 5866.73599688015, 5886.499647529922, 5904.911426328608, 6100.877982440326, 6103.511719062464, 6104.20645316106, 6110.205673262536, 6124.540659450559, 5969.671668058211, 5977.790777322773, 5987.520998320124, 6002.249718785152, 6005.369436209223, 5932.822015339547, 5970.0746384310505, 6019.849503762441, 6021.367756385516, 6026.035834266497, 4735.337052812609, 4788.3056956741075, 4801.735904525284, 4803.231482962779, 4825.30033145192, 4182.853600123981, 4283.357496375568, 4361.12777444506, 4362.672799540047, 4394.384786129945, 4047.777372244555, 4476.686631935733, 5047.570956468741, 5089.592832573459, 5480.123180291134, 5277.997180535686, 6091.634501929899, 6101.084837274356, 6143.877122457615, 6148.723307451086, 5303.071962406563, 5439.401665816757, 5488.0, 5498.862528436821, 5508.228847961289, 4336.934945975813, 5231.659942103751, 5247.658902171346, 5253.50091741284, 5314.202869569518, 5090.2364645303505, 5490.533304669148, 5868.706564671749, 6257.217847769029, 6282.089097080898, 5991.490723288569, 6096.817095487142, 6099.329073801967, 6118.877622447615, 6146.354632763496, 6136.720848337686, 6176.289726681489, 6192.195014648067, 6193.256809182747, 6199.628022318675, 5570.24801651788, 5996.1005849122985, 5998.850028749316, 6024.608400453956, 6029.125776762433, 5074.314967479343, 5929.0, 6064.02975523914, 6125.204929265209, 6152.077188421773, 5889.52883769306, 5902.38025007368, 5905.055191169392, 5906.675132867734, 5949.107633854784, 5676.0, 5843.853903652443, 5896.986824821972, 5949.0481522956115, 5957.225560677084, 5376.0, 5502.761878577288, 5618.325800903917, 5649.2373529574625, 5709.143628455765, 5781.971090144522, 5802.274715660543, 5813.302403711582, 5831.096180092092, 5836.9416305838095, 5687.914681279867, 5718.771249149988, 5720.628159169641, 5723.771049157987, 5744.827655170351], "unit": "score", "name": "dojo.html", "value": 5490.48433967957}, {"lowerIsBetter": false, "replicates": [463.5086807983538, 498.18795363557405, 559.7621011070294, 566.7223060700256, 598.757503211199, 25436.999999999978, 37639.05902352442, 37671.68149114785, 37677.623223767754, 37774.62225377745, 39267.60732392675, 39814.0046498837, 39898.800505997504, 40014.799556013364, 40063.19873602526, 9392.8591071134, 9572.521373931311, 9667.178289845371, 9677.612895484172, 9679.806403871919, 9397.530123493832, 9584.137427631511, 9664.081912218327, 9678.225741940663, 9696.660616878411, 9495.620175192984, 9532.332736708433, 9551.80896382072, 9555.952220238889, 9565.760855978586, 9569.234461243153, 9602.423854568713, 9701.417914925127, 9745.415275083518, 9821.410715357102, 8194.22154895284, 9691.854622180674, 9745.269104817096, 9745.415275083447, 9748.122668959828, 38190.80904595487, 38463.8076809617, 38595.61404385948, 38616.0, 38966.610333896584, 3138.73320767735, 3178.8728450861936, 3185.2036990752313, 3192.201949512622, 3307.1732066983254, 21695.0, 28855.0, 29288.267793305124, 29429.0, 30044.54933176004, 2540.212534114412, 2778.610994460777, 2797.6642802863785, 2842.403095349979, 2857.27139579408, 479542.0, 481044.0, 481890.0, 482013.1798682003, 482947.0, 55264.723676382164, 62901.68549157225, 63296.683516582125, 63311.6834415825, 64282.357176427635, 55721.721391392784, 56718.29845104653, 60937.39062609317, 61307.38692613106, 61570.69214653898, 14362.138271703523, 14991.0, 15613.141277229633, 16092.195390230441, 16328.510144695678, 9864.704058878246, 12285.57000504978, 12402.317872517098, 12404.875951240552, 12429.875701242872, 19486.512837179183, 19702.01489925498, 19953.401397957794, 20383.388498345073, 20409.79590204079, 8175.63209655567, 8337.458065225741, 8769.38614296993, 8945.239654629298, 8971.102889711106, 1031.2111234905303, 1035.49260862177, 1050.847627094067, 1154.1452637940185, 1161.9360935148648, 29175.124746257647, 29668.846569877573, 29881.701182988327, 29967.70032299649, 30241.848790755907, 1058.9932078710954, 1072.0191025211843, 1105.8562386889653, 1125.2685754259796, 1136.7044568412273, 12210.75578488443, 12562.623121306375, 14144.36350364236, 14804.963652544218, 15326.923365383325, 526718.0, 544776.0, 545184.0, 546658.0, 548414.0, 56941.71529142328, 57582.848343033744, 57649.0, 58081.128783068285, 58302.7084864573, 1419.2194293138732, 1436.727021865842, 1443.501991812844, 1450.7461194290956, 1553.9766903496457, 29029.27426814262, 29154.562681559368, 29166.0, 29748.10755677333, 29748.55377169301, 50392.49607503878, 50444.0, 50577.988440231726, 50605.24092138547, 50659.49340506548, 490807.0, 496608.0, 498379.0, 499698.0, 506845.4657726688, 30760.0, 32759.34481310313, 33698.15754606154, 33745.83127084447, 33782.81760138383, 40961.0, 41878.79060604677, 42277.57722422737, 42571.574284258, 43119.56880431281, 34542.0, 35147.648523514436, 35712.28575428529, 35782.46326305055, 36000.27999440049, 34877.82561087178, 35511.82244088763, 35728.28543429169, 35803.0, 36073.458898117075, 35537.28925421425, 36381.63618363783, 36496.63503364933, 36648.81675591605, 36652.45021324736, 31275.68724312728, 32732.018039458853, 32843.0, 32985.67014329826, 33085.83457082699, 22714.894595094076, 24423.0, 24431.14490992807, 24813.0, 24989.37526561778], "unit": "score", "name": "ext.html", "value": 19489.797761429956}, {"lowerIsBetter": false, "replicates": [361.93847046002185, 361.96380361963793, 362.472602363561, 371.12784955354937, 372.1700607644952, 15216.163111028889, 18894.433167004994, 19194.424167274985, 19335.903320483412, 19859.404217873453, 11608.0, 13516.594502164926, 17972.101394930265, 19207.519812004706, 19324.130414131363, 3599.064243296749, 4993.201087825949, 5280.709560974145, 5305.1776974569, 5581.609287349887, 5697.74360153792, 5745.798897038604, 5761.884762304772, 5764.855878603047, 5791.971040144794, 5716.742316690322, 6275.152854364671, 6285.214348206474, 6304.653244071575, 6307.653079080649, 5711.228984087136, 5719.199312096268, 5769.3653698093385, 6244.625322480643, 6382.648954307511, 5445.101558242885, 5456.399796022434, 5480.177973303997, 5489.313835770528, 5493.807716729895, 22098.116075356967, 22975.540489190123, 23112.537749244922, 23318.0, 23335.94988225534, 2046.4986078410736, 2119.237074653139, 2143.10335353212, 2191.6274233380364, 2221.4782873731547, 8017.318527925133, 9245.72262832116, 9752.756181095458, 9804.607815687365, 9907.0, 1534.6240171158026, 1668.2576253567167, 1705.7441383792407, 1723.7155869281553, 1728.7839020122485, 75025.62384692702, 88073.0, 95703.60740981462, 96475.51762241144, 102397.97602024033, 11233.98894099535, 11306.773864522827, 11339.886601134049, 11401.372924489067, 11458.77082458363, 13406.061575689802, 13510.594682159552, 13528.932355338357, 13554.118982266122, 13572.457101716018, 6858.451323894076, 8393.0, 8395.748127556182, 8500.97988241415, 8554.18735220153, 6864.4165245954655, 8413.0, 8449.070602233749, 8467.237948584658, 8557.44376615518, 4108.096218831853, 4263.424437700933, 4297.312430011246, 4419.0, 4423.336499525032, 1688.6285017296175, 1841.5488205389497, 1880.5110671225307, 1881.8494520438333, 1922.3367938061347, 390.7635880292439, 391.5555844116948, 898.5911410308294, 900.819836032783, 928.1831987850783, 11190.048845848194, 11666.416679166177, 11707.356095414834, 11721.35532545701, 11804.232724873027, 433.4040694045687, 445.4721155430825, 450.682269000354, 455.8632410276904, 465.7182404645209, 5962.612430192024, 6140.539459540552, 6146.078088286793, 6156.722947467285, 6198.287196972406, 310406.0, 701809.0, 702457.0, 719491.0, 721185.3644390677, 101429.0, 112204.43897780622, 112887.0, 112944.0, 114012.84702450584, 481.46557321373245, 485.28420579645444, 490.60996507776406, 491.34405568566365, 492.5640807885048, 10894.891051089704, 10976.890231097907, 11091.0, 11116.777664446827, 11159.38623375722, 45729.0, 47644.0, 48062.03875922392, 48313.27530087122, 48804.755976219894, 69846.30153698398, 73732.26267737254, 74198.25801742129, 74221.88667170105, 74568.25431745613, 7288.016117824026, 7550.3582195514, 7667.808304792425, 7750.6899724012665, 7792.4545281832, 11492.48283827213, 11772.52909883595, 11956.34240116802, 12014.519419223483, 12147.453364598437, 9135.862962055442, 10464.843027354747, 10564.630237941636, 10625.574977000833, 10786.676399708022, 9462.195713364441, 9984.850227246452, 10371.325863818827, 10599.682009539727, 10654.307470014424, 9159.76343193687, 9617.653528505874, 10047.34692245031, 10900.890991089987, 11059.391733454737, 7625.351845093229, 7644.235576442311, 7709.036370453693, 7723.652435640297, 7768.728094516665, 5680.857978550404, 9128.634854605742, 9700.902990970282, 10762.46187690628, 10895.0], "unit": "score", "name": "jquery.html", "value": 8185.6256333101655}, {"lowerIsBetter": false, "replicates": [1503.4963287298754, 1515.9393624255026, 1731.9653606927861, 1852.0369407907897, 1873.7470441490395, 8036.397270204729, 8698.56507174642, 8813.250873675737, 9024.142706442886, 9037.457752534845, 8779.122087791233, 8823.558822058903, 8920.95539522303, 8939.195472407482, 8955.731328060168, 2502.6120951252583, 2509.29739672891, 2519.4709111086695, 2533.936651583707, 2536.2771610091127, 2480.8635525046116, 2529.519391315653, 2533.100749234023, 2543.9618405723836, 2555.744425557448, 2217.1796435318956, 2450.2281781238853, 2500.1499490173337, 2523.7980961523035, 2535.847849129049, 2376.346504711201, 2386.4869053153657, 2386.653935179398, 2425.514897020594, 2431.942105184242, 2509.962350564743, 2523.8864251108744, 2525.2802951159015, 2533.74662533747, 2534.4931013797313, 8793.42842715228, 8810.295176385938, 8840.204381605621, 8845.292376609856, 8867.733967980907, 5410.161424979135, 5553.4724201200825, 5571.4428557143965, 5612.887742245132, 5623.49388555028, 3648.799316037617, 3723.5345581802276, 3783.224438990028, 3792.4500947362753, 3803.67668748154, 1051.1328154272678, 1074.554060065072, 1077.1113831089383, 1102.3496137279044, 1103.5971870267374, 9978.30151889368, 12053.975412089896, 12125.029997600172, 12135.878641213563, 12146.392680366034, 4862.270659401118, 5001.72490513018, 5024.145895197825, 5048.798048078036, 5074.213496907912, 10315.484225788681, 10366.118879895143, 10372.636957706443, 10399.584016639401, 10413.895861041445, 5583.581231407661, 5606.6916319602815, 5609.242752228479, 5627.8874422512135, 5628.099504079328, 4982.227754698028, 5034.0, 5068.518490743373, 5117.590592752571, 5124.359455068116, 4078.1843631273864, 4098.221337945781, 4099.651529620016, 4127.071408932966, 4134.338505839051, 1228.950841966329, 1340.3298350824587, 1341.3159288762606, 1348.3190988550916, 1354.5462270139615, 1085.766560189563, 1087.8150714378417, 1103.823388257875, 1203.7661397068075, 1213.902887768994, 7778.844423111506, 8081.393895457864, 8144.185581441809, 8214.8357032859, 8306.8338633227, 1160.4371879638368, 1161.5992482593492, 1169.4036041618665, 1175.048210949134, 1181.0669571038954, 6172.69136543171, 6227.06594010893, 6268.561200715997, 6275.717592708339, 6303.3066362700065, 10466.372017678812, 10676.733081673021, 10719.0, 10743.033127018449, 10837.945810270898, 10385.84421233682, 10493.9475302623, 10618.840717389245, 10664.680059598224, 10708.357498550113, 8287.751367458986, 8407.369447291478, 8411.327093832479, 8472.406931514857, 8493.702720404879, 8076.515409075474, 8254.587270636564, 8294.58527073632, 8319.500829950222, 8338.416310858182, 7363.631818409165, 9426.905730942603, 9762.219022478326, 9816.644005438786, 9819.36174148678, 9094.27245820346, 9505.572249248939, 9557.713268601952, 9864.950675246579, 9953.502324883582, 6311.936880631319, 7559.470837041575, 7640.770776876702, 7707.306342429209, 7753.728619498291, 6811.4550835934, 8197.877031844408, 8283.95858020706, 8290.544020078954, 8332.958335208285, 7408.888866667112, 7775.57234352116, 7885.605719713876, 8033.558154301336, 8058.758237252891, 7658.157602663591, 7697.769066928001, 7702.845943080995, 7778.455508114378, 7809.648565814666, 7803.648835802516, 7816.765497035098, 7849.254320839511, 7854.2145785421, 7876.330511906552, 6215.471684906834, 7056.470764692566, 7062.364387205176, 7091.716331346688, 7176.820579485555, 6036.547258955508, 7215.891761623685, 7253.601051942193, 7274.527155734861, 7359.448041397024], "unit": "score", "name": "mootools.html", "value": 5002.792978687268}, {"lowerIsBetter": false, "replicates": [290.5569007263923, 327.11841586923254, 330.1498640999427, 330.5240453746606, 331.3538599730525, 6692.598444093358, 6806.353396427331, 6846.144231971004, 6935.445164386843, 6935.44516438685, 6846.965765171167, 6877.89683154753, 6880.036794848726, 6894.5518541294905, 6917.4466042716585, 5101.872453188681, 5105.821296254632, 5122.564582010534, 5125.820596279131, 5139.408967968694, 3846.307664620367, 5094.79620815167, 5101.795928162887, 5122.871928201787, 5129.512696293846, 4909.656324057318, 4919.483454237307, 4923.990581930713, 4927.6550641455115, 4931.235658472942, 4184.895377615553, 4904.48502907195, 4906.264060390934, 4936.259561065833, 4940.728259945701, 3955.129871428281, 4047.2107938951917, 4159.625633692982, 4168.541460439349, 4195.91608167835, 5778.757567123047, 6078.422549857801, 6564.0, 6584.703688334036, 6617.636030018347, 5843.561732870052, 5844.298684157886, 5863.9706801466145, 5877.5591830612875, 5883.17635531026, 7040.718371265194, 7279.417646588313, 7281.817954551126, 7304.160021597531, 7307.4884758066955, 4633.884152896171, 4670.1126785910565, 4670.159371313162, 4670.392848929651, 4673.696209746356, 6254.624722516618, 7636.656350464187, 7688.0, 7715.189905059944, 7723.729669461542, 4081.0817566047995, 4174.666026717855, 4531.524189960072, 4701.529847015339, 4708.835190768306, 4802.567768900746, 4820.469748327681, 4826.831060912921, 4832.323474713543, 4840.0, 5803.636145505803, 5806.622569532967, 5818.040023396177, 5832.096025116029, 5834.94165058344, 7319.377852882458, 7319.377852882564, 7330.560166390033, 7344.045274114331, 7375.151857536344, 1501.0843385534815, 1502.8722558582642, 1669.8497135257885, 1673.305578185064, 1678.1106013812698, 930.9898759845508, 1043.8121138195197, 1062.8246339354075, 1068.7114479090758, 1071.8660167479065, 5472.0, 5862.355140934494, 6456.418922297016, 6820.897686534706, 6826.771181187434, 7545.547267163988, 7573.2048134946135, 7599.0, 7602.961985190039, 7606.315431611181, 5504.9449505504435, 6168.845778855564, 6795.898061529081, 6827.249002609709, 6838.14523184602, 3205.8557364918634, 3898.3762597984187, 4003.399490076512, 4015.2772500949527, 4092.4884389451317, 6468.256150542654, 7927.722529711433, 7976.641051152712, 7980.3615710743, 8064.959675201704, 6441.806745797634, 7936.642851071716, 7953.2842044216295, 7954.920450795534, 7961.840763184704, 7730.994970653892, 8057.879131813028, 8073.838523229385, 8111.594420279081, 8118.35053195743, 6964.373206411245, 7704.768856934301, 7741.303282704584, 7762.379009679099, 7790.182030886902, 7363.484556081023, 7545.245475452631, 7564.583947882699, 7565.092188937363, 7588.27911348421, 8025.719099831478, 8038.517688938682, 8060.83878322442, 8074.192580741878, 8080.313173380094, 4738.810447582058, 4787.138315103315, 4806.351142595705, 4809.014152098742, 4828.082664293773, 7404.703811847466, 7631.580263085583, 7661.540307581563, 7690.1925297845155, 7696.307332339892, 7389.408847292097, 7399.852002960019, 7413.332800048021, 7414.998975138503, 7417.666205020895, 7131.0, 7404.888926666212, 7418.480706350504, 7422.220666830121, 7434.959105725095, 7233.782986510413, 7236.710531578678, 7261.273872612696, 7267.0, 7309.049823522908, 6044.425779550936, 6400.97584386496, 6954.687039083152, 7403.66683499233, 7420.109586849612, 5692.231548740867, 7247.891281630885, 7255.4921155518605, 7266.200717920919, 7288.12542494904], "unit": "score", "name": "prototype.html", "value": 5260.351981476142}, {"lowerIsBetter": false, "replicates": [577.968326537131, 654.9476041916647, 678.5860625018738, 714.1895295426093, 725.4414101142121, 13733.65665858354, 14633.414663413463, 14833.035852669569, 14845.257737113156, 14871.182084985336, 12470.37648117595, 13349.733005339887, 13364.866351336485, 13373.331333433314, 13394.330283485835, 680.2585182151454, 827.3298628111219, 832.8584140696096, 856.297835774665, 860.8493513635088, 832.3216578488513, 838.5010918503481, 846.5047946951041, 849.7110982266029, 849.800296930221, 903.7740564858785, 903.9728808135734, 904.0, 904.398574947659, 905.2441211588332, 899.1772528136747, 901.1079031758577, 901.1394118616738, 901.5717534171249, 905.5698543191965, 663.4327649859397, 670.4803777072759, 673.1182151381705, 673.2728653054689, 674.3122015544118, 14172.29138543079, 14195.78706319406, 14308.356123974447, 14422.567322980327, 14680.632984175481, 12837.0, 12855.485780568766, 12928.0, 13211.075224734272, 13385.26381049042, 10033.59865605375, 10144.239182061376, 10159.441230732307, 10174.949125254401, 10262.179025678002, 2918.897838575661, 3542.3446662367546, 3564.376234159012, 3615.2950174715943, 3646.6682216785102, 79578.0, 80465.0, 80889.59555202187, 81373.59313203456, 82611.17388826095, 9557.426554406758, 9664.468454235084, 9781.951090244504, 9790.510474476248, 9851.451086768247, 21835.781642183694, 22068.558628827333, 22093.0, 22096.33710988673, 22178.889105554368, 7515.887261691079, 7594.0, 7748.690052397841, 7795.883061754078, 7944.126146123922, 4029.174019326031, 4032.2540330039037, 4038.7980600970423, 4088.8773336799945, 4103.138340948434, 3631.1648320886343, 3650.178709790276, 3658.762180458262, 3671.100580357776, 3677.8344974476213, 682.5631595778706, 701.421327404893, 713.728783062433, 716.5056111283197, 724.0298000679115, 432.7490055767647, 522.344457705577, 567.4268988321742, 591.9289685237799, 614.9292831324454, 7386.113666360071, 7802.804929876685, 8387.454815436977, 8508.149185081566, 8608.397412181212, 522.1567169022078, 604.5496105401504, 609.2719200555382, 609.3479976425272, 623.9313675495691, 3865.4974853268895, 3885.6502914737243, 3887.1059656279213, 4235.0, 4313.84901528445, 80082.59958700169, 96028.51985740027, 96306.51846740721, 97447.53828692576, 101527.98472015333, 83361.0, 83586.0, 84094.0, 84202.0, 84264.0, 65974.0, 66633.0, 68316.0, 69474.95787563191, 71415.6429217861, 7224.988501609884, 7489.962550187214, 8665.17680820321, 8762.342824288076, 8795.560221988748, 50082.74958625183, 50109.498905010485, 50608.746956264986, 50753.49246507488, 51402.97194056023, 38163.42754858624, 60032.39967600268, 68698.0, 70657.0, 72178.0, 10836.783264334512, 11121.332720036824, 11240.494177762184, 11321.886781132413, 11683.88316116828, 11547.422628868691, 11747.177697561088, 11797.941010294893, 11959.581414650445, 12251.87748122543, 11532.711682208012, 11559.0, 11654.941725291319, 11659.125565582446, 11659.825102623638, 9379.577918993526, 9593.376430531993, 11114.666560003212, 11471.827922581335, 11591.6522504325, 8135.7152499662225, 10562.994673701904, 10700.411477368509, 10798.0, 11018.11855051578, 8112.0, 8674.915635545556, 8899.688510902088, 9037.231835294073, 9182.026501942704, 9519.904800951901, 9600.039996000623, 9642.132208101304, 9656.5638495063, 9700.5149742514], "unit": "score", "name": "yui.html", "value": 6803.45591647784}], "name": "dromaeo_css", "value": 7343.6155042880155}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 114.0, 114.0, 116.0, 124.0, 116.0, 124.0, 171.0, 166.0], "unit": "score", "name": "ai-astar", "value": 126.8}, {"lowerIsBetter": true, "replicates": [161.0, 144.0, 160.0, 147.0, 112.0, 193.0, 174.0, 158.0, 158.0, 142.0], "unit": "score", "name": "audio-beat-detection", "value": 154.9}, {"lowerIsBetter": true, "replicates": [199.0, 199.0, 206.0, 216.0, 227.0, 199.0, 196.0, 204.0, 204.0, 198.0], "unit": "score", "name": "audio-dft", "value": 204.8}, {"lowerIsBetter": true, "replicates": [84.0, 69.0, 76.0, 111.0, 64.0, 64.0, 83.0, 91.0, 149.0, 72.0], "unit": "score", "name": "audio-fft", "value": 86.3}, {"lowerIsBetter": true, "replicates": [84.0, 88.0, 113.0, 79.0, 81.0, 82.0, 118.0, 81.0, 83.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 92.3}, {"lowerIsBetter": true, "replicates": [85.0, 91.0, 85.0, 92.0, 126.0, 102.0, 85.0, 92.0, 84.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.3}, {"lowerIsBetter": true, "replicates": [152.0, 130.0, 94.0, 96.0, 95.0, 119.0, 156.0, 104.0, 95.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 113.7}, {"lowerIsBetter": true, "replicates": [90.0, 101.0, 93.0, 90.0, 100.0, 93.0, 92.0, 132.0, 156.0, 143.0], "unit": "score", "name": "imaging-desaturate", "value": 109.0}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 54.0, 56.0, 57.0, 56.0, 57.0, 62.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 71.0, 65.0, 80.0, 73.0, 69.0, 65.0, 67.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 86.0, 84.0, 87.0, 83.0, 86.0, 85.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [131.0, 134.0, 115.0, 152.0, 141.0, 130.0, 142.0, 125.0, 140.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 134.6}, {"lowerIsBetter": true, "replicates": [140.0, 145.0, 146.0, 141.0, 143.0, 148.0, 178.0, 128.0, 182.0, 165.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.6}, {"lowerIsBetter": true, "replicates": [68.0, 73.0, 95.0, 99.0, 99.0, 96.0, 100.0, 56.0, 75.0, 99.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 86.0}], "name": "kraken", "value": 1564.3999999999999}]} 05:40:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1564.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7343.61"}}} 05:40:32 INFO - Return code: 0 05:40:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:40:32 INFO - # TBPL SUCCESS # 05:40:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:40:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:40:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:40:32 INFO - 2016-02-16 05:40:32.609 screenresolution[2980:84917] starting screenresolution argv=screenresolution get 05:40:32 INFO - 2016-02-16 05:40:32.612 screenresolution[2980:84917] Display 0: 1600x1200x32@60 05:40:32 INFO - 2016-02-16 05:40:32.618 screenresolution[2981:84919] starting screenresolution argv=screenresolution list 05:40:32 INFO - Available Modes on Display 0 05:40:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:40:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:40:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:40:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:40:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:40:32 INFO - Intel Iris: 05:40:32 INFO - Chipset Model: Intel Iris 05:40:32 INFO - Type: GPU 05:40:32 INFO - Bus: Built-In 05:40:32 INFO - VRAM (Dynamic, Max): 1536 MB 05:40:32 INFO - Vendor: Intel (0x8086) 05:40:32 INFO - Device ID: 0x0a2e 05:40:32 INFO - Revision ID: 0x0009 05:40:32 INFO - Displays: 05:40:32 INFO - Display: 05:40:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:40:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:40:32 INFO - Display Serial Number: 1600x1200 60 05:40:32 INFO - Main Display: Yes 05:40:32 INFO - Mirror: Off 05:40:32 INFO - Online: Yes 05:40:32 INFO - Rotation: Supported 05:40:32 INFO - Return code: 0 05:40:32 INFO - Running post-action listener: _resource_record_post_action 05:40:32 INFO - Running post-run listener: _resource_record_post_run 05:40:33 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 974848; Write bytes: 712121856; Read time: 13; Write time: 2007 05:40:33 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399139328; Write bytes: 392922624; Read time: 29925; Write time: 671 05:40:33 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 974848; Write bytes: 305547264; Read time: 13; Write time: 1300 05:40:33 INFO - Running post-run listener: _upload_blobber_files 05:40:33 INFO - Blob upload gear active. 05:40:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:40:33 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 05:40:33 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:40:33 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:40:34 INFO - (blobuploader) - INFO - Open directory for files ... 05:40:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:40:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:40:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:35 INFO - (blobuploader) - INFO - Done attempting. 05:40:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:40:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:40:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:36 INFO - (blobuploader) - INFO - Done attempting. 05:40:36 INFO - (blobuploader) - INFO - Iteration through files over. 05:40:36 INFO - Return code: 0 05:40:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:40:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:40:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ac616073ebec10d8027bca03709b8a46502ca6fe48ecb4d4b2047f93e8739b153c5397c77b1f3d57cf3cdd75f6924194628600dcdaf13cc6f13b812e18f5817", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5c7e6c325f5ea2753ef5e01efec2545006aded791d27c4a879ac31c7041983e5902854b04476808e5c2633666fda0e12aa308fe956375b895f4d292490bac03"} 05:40:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:40:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:40:36 INFO - Contents: 05:40:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ac616073ebec10d8027bca03709b8a46502ca6fe48ecb4d4b2047f93e8739b153c5397c77b1f3d57cf3cdd75f6924194628600dcdaf13cc6f13b812e18f5817", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5c7e6c325f5ea2753ef5e01efec2545006aded791d27c4a879ac31c7041983e5902854b04476808e5c2633666fda0e12aa308fe956375b895f4d292490bac03"} 05:40:36 INFO - Running post-run listener: copy_logs_to_upload_dir 05:40:36 INFO - Copying logs to upload dir... 05:40:36 INFO - mkdir: /builds/slave/test/build/upload/logs 05:40:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1345.931076 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2016-02-16 05:40:36.559161) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 05:40:36.562585) ========= 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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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/Firefox/sha512/1ac616073ebec10d8027bca03709b8a46502ca6fe48ecb4d4b2047f93e8739b153c5397c77b1f3d57cf3cdd75f6924194628600dcdaf13cc6f13b812e18f5817", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5c7e6c325f5ea2753ef5e01efec2545006aded791d27c4a879ac31c7041983e5902854b04476808e5c2633666fda0e12aa308fe956375b895f4d292490bac03"} build_url:https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011740 build_url: 'https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ac616073ebec10d8027bca03709b8a46502ca6fe48ecb4d4b2047f93e8739b153c5397c77b1f3d57cf3cdd75f6924194628600dcdaf13cc6f13b812e18f5817", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5c7e6c325f5ea2753ef5e01efec2545006aded791d27c4a879ac31c7041983e5902854b04476808e5c2633666fda0e12aa308fe956375b895f4d292490bac03"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 05:40:36.594111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:40:36.594780) ========= 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.CZHDZ7T8x9/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.skAZRhLSwY/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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.005265 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:40:36.647979) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 05:40:36.648759) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 05:40:36.649607) ========= ========= Total master_lag: 0.75 =========