builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0067 starttime: 1456980318.45 results: success (0) buildid: 20160302195121 builduid: 113a5110a79746c687ab5c81f8ac09d2 revision: 38d23f0168980b27bb88bf20a8cba7f907bc495e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 20:45:18.452672) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 20:45:18.453118) ========= ========= Started set props: basedir (results: 0, elapsed: 17 secs) (at 2016-03-02 20:45:18.453438) ========= 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.oVD7WUcXKt/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.m0E0eugPUG/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.006030 basedir: '/builds/slave/test' ========= master_lag: 17.14 ========= ========= Finished set props: basedir (results: 0, elapsed: 17 secs) (at 2016-03-02 20:45:35.600610) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 10 secs) (at 2016-03-02 20:45:35.600931) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 10 secs) (at 2016-03-02 20:45:46.396218) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-02 20:45:46.399555) ========= 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.oVD7WUcXKt/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.m0E0eugPUG/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005896 ========= master_lag: 3.59 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-02 20:45:49.991711) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 20:45:49.992038) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 20:45:49.992402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-02 20:45:49.992671) ========= 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.oVD7WUcXKt/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.m0E0eugPUG/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-02 20:45:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 25.4M=0s 2016-03-02 20:45:51 (25.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.559729 ========= master_lag: 1.53 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-02 20:45:52.077672) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-03-02 20:45:52.077974) ========= 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.oVD7WUcXKt/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.m0E0eugPUG/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.026933 ========= master_lag: 5.67 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-03-02 20:45:57.773995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-03-02 20:45:57.774322) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 38d23f0168980b27bb88bf20a8cba7f907bc495e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 38d23f0168980b27bb88bf20a8cba7f907bc495e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oVD7WUcXKt/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.m0E0eugPUG/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-02 20:45:57,978 truncating revision to first 12 chars 2016-03-02 20:45:57,978 Setting DEBUG logging. 2016-03-02 20:45:57,978 attempt 1/10 2016-03-02 20:45:57,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/38d23f016898?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 20:45:59,319 unpacking tar archive at: fx-team-38d23f016898/testing/mozharness/ program finished with exit code 0 elapsedTime=1.590961 ========= master_lag: 4.46 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-03-02 20:46:03.825700) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-02 20:46:03.825998) ========= echo 38d23f0168980b27bb88bf20a8cba7f907bc495e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'38d23f0168980b27bb88bf20a8cba7f907bc495e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oVD7WUcXKt/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.m0E0eugPUG/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 38d23f0168980b27bb88bf20a8cba7f907bc495e program finished with exit code 0 elapsedTime=0.006331 script_repo_revision: '38d23f0168980b27bb88bf20a8cba7f907bc495e' ========= master_lag: 1.37 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-02 20:46:05.202058) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-03-02 20:46:05.205374) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-03-02 20:46:06.223949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 33 secs) (at 2016-03-02 20:46:06.224366) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oVD7WUcXKt/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.m0E0eugPUG/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 20:46:06 INFO - MultiFileLogger online at 20160302 20:46:06 in /builds/slave/test 20:46:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:46:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:46:06 INFO - {'append_to_log': False, 20:46:06 INFO - 'base_work_dir': '/builds/slave/test', 20:46:06 INFO - 'blob_upload_branch': 'Fx-Team', 20:46:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:46:06 INFO - 'branch': 'Fx-Team', 20:46:06 INFO - 'buildbot_json_path': 'buildprops.json', 20:46:06 INFO - 'config_files': ('talos/mac_config.py',), 20:46:06 INFO - 'default_actions': ('clobber', 20:46:06 INFO - 'read-buildbot-config', 20:46:06 INFO - 'download-and-extract', 20:46:06 INFO - 'populate-webroot', 20:46:06 INFO - 'create-virtualenv', 20:46:06 INFO - 'install', 20:46:06 INFO - 'run-tests'), 20:46:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:46:06 INFO - 'download_minidump_stackwalk': True, 20:46:06 INFO - 'download_symbols': 'ondemand', 20:46:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:46:06 INFO - 'tooltool.py': '/tools/tooltool.py', 20:46:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:46:06 INFO - '/tools/misc-python/virtualenv.py')}, 20:46:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:46:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:46:06 INFO - 'installer_path': 'installer.exe', 20:46:06 INFO - 'log_level': 'info', 20:46:06 INFO - 'log_name': 'talos', 20:46:06 INFO - 'log_to_console': True, 20:46:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:46:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:46:06 INFO - 'opt_config_files': (), 20:46:06 INFO - 'pip_index': False, 20:46:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:46:06 INFO - 'cmd': ('bash', 20:46:06 INFO - '-c', 20:46:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:46:06 INFO - 'enabled': True, 20:46:06 INFO - 'halt_on_failure': False, 20:46:06 INFO - 'name': 'check_screen_resolution'},), 20:46:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:46:06 INFO - 'cmd': ('bash', 20:46:06 INFO - '-c', 20:46:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:46:06 INFO - 'enabled': True, 20:46:06 INFO - 'halt_on_failure': False, 20:46:06 INFO - 'name': 'check_screen_resolution'},), 20:46:06 INFO - 'run_cmd_checks_enabled': True, 20:46:06 INFO - 'sps_profile': False, 20:46:06 INFO - 'sps_profile_interval': 0, 20:46:06 INFO - 'suite': 'dromaeojs-e10s', 20:46:06 INFO - 'system_bits': '32', 20:46:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:46:06 INFO - 'title': 't-yosemite-r7-0067', 20:46:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:46:06 INFO - 'use_talos_json': True, 20:46:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:46:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:46:06 INFO - 'work_dir': 'build'} 20:46:06 INFO - ##### 20:46:06 INFO - ##### Running clobber step. 20:46:06 INFO - ##### 20:46:06 INFO - Running pre-action listener: _resource_record_pre_action 20:46:06 INFO - Running main action method: clobber 20:46:06 INFO - rmtree: /builds/slave/test/build 20:46:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:46:08 INFO - Running post-action listener: _resource_record_post_action 20:46:08 INFO - ##### 20:46:08 INFO - ##### Running read-buildbot-config step. 20:46:08 INFO - ##### 20:46:08 INFO - Running pre-action listener: _resource_record_pre_action 20:46:08 INFO - Running main action method: read_buildbot_config 20:46:08 INFO - Using buildbot properties: 20:46:08 INFO - { 20:46:08 INFO - "project": "", 20:46:08 INFO - "product": "firefox", 20:46:08 INFO - "script_repo_revision": "production", 20:46:08 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 20:46:08 INFO - "repository": "", 20:46:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 20:46:08 INFO - "buildid": "20160302195121", 20:46:08 INFO - "pgo_build": "False", 20:46:08 INFO - "basedir": "/builds/slave/test", 20:46:08 INFO - "buildnumber": 572, 20:46:08 INFO - "slavename": "t-yosemite-r7-0067", 20:46:08 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 20:46:08 INFO - "platform": "yosemite_r7", 20:46:08 INFO - "scheduler": "tests-fx-team-macosx64-talos", 20:46:08 INFO - "branch": "fx-team", 20:46:08 INFO - "repo_path": "integration/fx-team", 20:46:08 INFO - "revision": "38d23f0168980b27bb88bf20a8cba7f907bc495e", 20:46:08 INFO - "stage_platform": "macosx64", 20:46:08 INFO - "builduid": "113a5110a79746c687ab5c81f8ac09d2", 20:46:08 INFO - "slavebuilddir": "test" 20:46:08 INFO - } 20:46:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 20:46:08 INFO - Running post-action listener: _resource_record_post_action 20:46:08 INFO - ##### 20:46:08 INFO - ##### Running download-and-extract step. 20:46:08 INFO - ##### 20:46:08 INFO - Running pre-action listener: _resource_record_pre_action 20:46:08 INFO - Running main action method: download_and_extract 20:46:08 INFO - mkdir: /builds/slave/test/build/tests 20:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:08 INFO - https://queue.taskcluster.net/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 20:46:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 20:46:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 20:46:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 20:46:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 20:46:09 INFO - Downloaded 1277 bytes. 20:46:09 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 20:46:09 INFO - Using the following test package requirements: 20:46:09 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:46:09 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:46:09 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 20:46:09 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:46:09 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 20:46:09 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:46:09 INFO - u'jsshell-mac.zip'], 20:46:09 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:46:09 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 20:46:09 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:46:09 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:46:09 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 20:46:09 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:46:09 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 20:46:09 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:46:09 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 20:46:09 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:46:09 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:46:09 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 20:46:09 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:46:09 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')]} 20:46:09 INFO - https://queue.taskcluster.net/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:46:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:46:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:46:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/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 20:46:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/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 20:46:10 INFO - Downloaded 17854995 bytes. 20:46:10 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'] 20:46:10 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 20:46:13 INFO - Return code: 0 20:46:13 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 20:46:13 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')]} 20:46:13 INFO - https://queue.taskcluster.net/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:46:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:46:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:46:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/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 20:46:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/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 20:46:19 INFO - Downloaded 17854995 bytes. 20:46:19 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'] 20:46:19 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 20:46:23 INFO - Return code: 0 20:46:23 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')]} 20:46:23 INFO - https://queue.taskcluster.net/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:46:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 20:46:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 20:46:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/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 20:46:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/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 20:46:23 INFO - Downloaded 10808263 bytes. 20:46:23 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'] 20:46:23 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 20:46:24 INFO - Return code: 0 20:46:24 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')]} 20:46:24 INFO - https://queue.taskcluster.net/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 20:46:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:46:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:46:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 20:46:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/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 20:46:28 INFO - Downloaded 110961414 bytes. 20:46:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:46:28 INFO - mkdir: /builds/slave/test/properties 20:46:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:46:28 INFO - Writing to file /builds/slave/test/properties/build_url 20:46:28 INFO - Contents: 20:46:28 INFO - build_url:https://queue.taskcluster.net/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:46:29 INFO - Running post-action listener: _resource_record_post_action 20:46:29 INFO - Running post-action listener: set_extra_try_arguments 20:46:29 INFO - ##### 20:46:29 INFO - ##### Running populate-webroot step. 20:46:29 INFO - ##### 20:46:29 INFO - Running pre-action listener: _resource_record_pre_action 20:46:29 INFO - Running main action method: populate_webroot 20:46:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:46:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:46:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:46:29 INFO - '--tppagecycles', 20:46:29 INFO - '7'], 20:46:29 INFO - 'tests': ['tsvgm']}}, 20:46:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:46:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:46:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:46:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:46:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:46:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:46:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:46:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:29 INFO - 'talos_options': ['--e10s'], 20:46:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:46:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:29 INFO - 'tests': ['damp', 'tps']}, 20:46:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:29 INFO - 'talos_options': ['--e10s'], 20:46:29 INFO - 'tests': ['damp', 'tps']}, 20:46:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:46:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:46:29 INFO - 'other': {'tests': ['a11yr', 20:46:29 INFO - 'ts_paint', 20:46:29 INFO - 'tpaint', 20:46:29 INFO - 'sessionrestore', 20:46:29 INFO - 'sessionrestore_no_auto_restore']}, 20:46:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:46:29 INFO - 'tests': ['a11yr', 20:46:29 INFO - 'ts_paint', 20:46:29 INFO - 'tpaint', 20:46:29 INFO - 'sessionrestore', 20:46:29 INFO - 'sessionrestore_no_auto_restore']}, 20:46:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:46:29 INFO - 'tests': ['a11yr', 20:46:29 INFO - 'ts_paint', 20:46:29 INFO - 'tpaint', 20:46:29 INFO - 'sessionrestore', 20:46:29 INFO - 'sessionrestore_no_auto_restore']}, 20:46:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:46:29 INFO - 'tests': ['a11yr', 20:46:29 INFO - 'ts_paint', 20:46:29 INFO - 'tpaint', 20:46:29 INFO - 'sessionrestore', 20:46:29 INFO - 'sessionrestore_no_auto_restore']}, 20:46:29 INFO - 'other_l64': {'tests': ['a11yr', 20:46:29 INFO - 'ts_paint', 20:46:29 INFO - 'tpaint', 20:46:29 INFO - 'sessionrestore', 20:46:29 INFO - 'sessionrestore_no_auto_restore']}, 20:46:29 INFO - 'other_nol64': {'tests': ['a11yr', 20:46:29 INFO - 'ts_paint', 20:46:29 INFO - 'tpaint', 20:46:29 INFO - 'sessionrestore', 20:46:29 INFO - 'sessionrestore_no_auto_restore']}, 20:46:29 INFO - 'svgr': {'tests': ['tsvgx', 20:46:29 INFO - 'tsvgr_opacity', 20:46:29 INFO - 'tart', 20:46:29 INFO - 'tscrollx', 20:46:29 INFO - 'cart']}, 20:46:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:46:29 INFO - 'tests': ['tsvgx', 20:46:29 INFO - 'tsvgr_opacity', 20:46:29 INFO - 'tart', 20:46:29 INFO - 'tscrollx', 20:46:29 INFO - 'cart']}, 20:46:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:29 INFO - 'tests': ['tp5o']}, 20:46:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:29 INFO - 'talos_options': ['--e10s'], 20:46:29 INFO - 'tests': ['tp5o']}, 20:46:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:29 INFO - 'talos_options': ['--xperf_path', 20:46:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:46:29 INFO - 'tests': ['tp5n']}, 20:46:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:29 INFO - 'talos_options': ['--e10s', 20:46:29 INFO - '--xperf_path', 20:46:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:46:29 INFO - 'tests': ['tp5n']}}, 20:46:29 INFO - 'talos.zip': {'path': '', 20:46:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:46:29 INFO - Running post-action listener: _resource_record_post_action 20:46:29 INFO - ##### 20:46:29 INFO - ##### Running create-virtualenv step. 20:46:29 INFO - ##### 20:46:29 INFO - Running pre-action listener: _resource_record_pre_action 20:46:29 INFO - Running main action method: create_virtualenv 20:46:29 INFO - Creating virtualenv /builds/slave/test/build/venv 20:46:29 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 20:46:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:46:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:46:29 INFO - Using real prefix '/tools/python27' 20:46:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:46:30 INFO - Installing distribute.............................................................................................................................................................................................done. 20:46:33 INFO - Installing pip.................done. 20:46:33 INFO - Return code: 0 20:46:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:33 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 0x10336fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd430c82870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103213d30>, '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 0x103037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10320ab20>, '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.oVD7WUcXKt/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.m0E0eugPUG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 20:46:33 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 20:46:33 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 20:46:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oVD7WUcXKt/Render', 20:46:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:33 INFO - 'HOME': '/Users/cltbld', 20:46:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:33 INFO - 'LOGNAME': 'cltbld', 20:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:33 INFO - 'MOZ_NO_REMOTE': '1', 20:46:33 INFO - 'NO_EM_RESTART': '1', 20:46:33 INFO - 'PAGER': '/bin/cat', 20:46:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:33 INFO - 'PWD': '/builds/slave/test', 20:46:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:33 INFO - 'SHELL': '/bin/bash', 20:46:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m0E0eugPUG/Listeners', 20:46:33 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 20:46:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:33 INFO - 'USER': 'cltbld', 20:46:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:33 INFO - 'XPC_FLAGS': '0x0', 20:46:33 INFO - 'XPC_SERVICE_NAME': '0', 20:46:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:33 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 20:46:33 INFO - Cleaning up... 20:46:33 INFO - Return code: 0 20:46:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:33 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 0x10336fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd430c82870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103213d30>, '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 0x103037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10320ab20>, '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.oVD7WUcXKt/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.m0E0eugPUG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 20:46:33 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 20:46:33 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 20:46:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oVD7WUcXKt/Render', 20:46:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:33 INFO - 'HOME': '/Users/cltbld', 20:46:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:33 INFO - 'LOGNAME': 'cltbld', 20:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:33 INFO - 'MOZ_NO_REMOTE': '1', 20:46:33 INFO - 'NO_EM_RESTART': '1', 20:46:33 INFO - 'PAGER': '/bin/cat', 20:46:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:33 INFO - 'PWD': '/builds/slave/test', 20:46:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:33 INFO - 'SHELL': '/bin/bash', 20:46:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m0E0eugPUG/Listeners', 20:46:33 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 20:46:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:33 INFO - 'USER': 'cltbld', 20:46:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:33 INFO - 'XPC_FLAGS': '0x0', 20:46:33 INFO - 'XPC_SERVICE_NAME': '0', 20:46:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:34 INFO - Downloading/unpacking psutil>=0.7.1 20:46:34 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 20:46:34 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 20:46:34 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 20:46:34 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 20:46:34 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 20:46:34 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 20:46:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:46:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:46:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:46:36 INFO - Installing collected packages: psutil 20:46:36 INFO - Running setup.py install for psutil 20:46:37 INFO - building 'psutil._psutil_osx' extension 20:46:37 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 20:46:37 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 20:46:37 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 20:46:37 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 20:46:37 INFO - building 'psutil._psutil_posix' extension 20:46:37 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 20:46:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:46:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:46:37 INFO - ^ 20:46:37 INFO - 1 warning generated. 20:46:37 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 20:46:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:46:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:46:38 INFO - Successfully installed psutil 20:46:38 INFO - Cleaning up... 20:46:38 INFO - Return code: 0 20:46:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:46:38 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')]} 20:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:38 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')]} 20:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:38 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 0x10336fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd430c82870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103213d30>, '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 0x103037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10320ab20>, '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.oVD7WUcXKt/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.m0E0eugPUG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 20:46:38 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 20:46:38 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 20:46:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oVD7WUcXKt/Render', 20:46:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:38 INFO - 'HOME': '/Users/cltbld', 20:46:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:38 INFO - 'LOGNAME': 'cltbld', 20:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:38 INFO - 'MOZ_NO_REMOTE': '1', 20:46:38 INFO - 'NO_EM_RESTART': '1', 20:46:38 INFO - 'PAGER': '/bin/cat', 20:46:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:38 INFO - 'PWD': '/builds/slave/test', 20:46:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:38 INFO - 'SHELL': '/bin/bash', 20:46:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m0E0eugPUG/Listeners', 20:46:38 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 20:46:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:38 INFO - 'USER': 'cltbld', 20:46:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:38 INFO - 'XPC_FLAGS': '0x0', 20:46:38 INFO - 'XPC_SERVICE_NAME': '0', 20:46:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:46:38 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 20:46:38 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 20:46:38 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 20:46:38 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 20:46:38 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 20:46:38 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 20:46:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:46:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:46:40 INFO - Installing collected packages: mozsystemmonitor 20:46:40 INFO - Running setup.py install for mozsystemmonitor 20:46:40 INFO - Successfully installed mozsystemmonitor 20:46:40 INFO - Cleaning up... 20:46:41 INFO - Return code: 0 20:46:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:41 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 0x10336fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd430c82870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103213d30>, '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 0x103037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10320ab20>, '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.oVD7WUcXKt/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.m0E0eugPUG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 20:46:41 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 20:46:41 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 20:46:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oVD7WUcXKt/Render', 20:46:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:41 INFO - 'HOME': '/Users/cltbld', 20:46:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:41 INFO - 'LOGNAME': 'cltbld', 20:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:41 INFO - 'MOZ_NO_REMOTE': '1', 20:46:41 INFO - 'NO_EM_RESTART': '1', 20:46:41 INFO - 'PAGER': '/bin/cat', 20:46:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:41 INFO - 'PWD': '/builds/slave/test', 20:46:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:41 INFO - 'SHELL': '/bin/bash', 20:46:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m0E0eugPUG/Listeners', 20:46:41 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 20:46:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:41 INFO - 'USER': 'cltbld', 20:46:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:41 INFO - 'XPC_FLAGS': '0x0', 20:46:41 INFO - 'XPC_SERVICE_NAME': '0', 20:46:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:41 INFO - Downloading/unpacking blobuploader==1.2.4 20:46:41 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 20:46:41 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 20:46:41 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 20:46:41 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 20:46:41 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 20:46:41 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 20:46:43 INFO - Downloading blobuploader-1.2.4.tar.gz 20:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:46:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:46:43 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 20:46:43 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 20:46:43 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 20:46:43 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 20:46:43 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 20:46:43 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 20:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:46:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:46:44 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 20:46:44 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 20:46:44 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 20:46:44 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 20:46:44 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 20:46:44 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 20:46:44 INFO - Downloading docopt-0.6.1.tar.gz 20:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:46:45 INFO - Installing collected packages: blobuploader, requests, docopt 20:46:45 INFO - Running setup.py install for blobuploader 20:46:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:46:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:46:45 INFO - Running setup.py install for requests 20:46:45 INFO - Running setup.py install for docopt 20:46:45 INFO - Successfully installed blobuploader requests docopt 20:46:45 INFO - Cleaning up... 20:46:45 INFO - Return code: 0 20:46:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46: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')]} 20:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46: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')]} 20:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:45 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 0x10336fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd430c82870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103213d30>, '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 0x103037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10320ab20>, '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.oVD7WUcXKt/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.m0E0eugPUG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 20:46:45 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 20:46:45 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 20:46:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oVD7WUcXKt/Render', 20:46:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:45 INFO - 'HOME': '/Users/cltbld', 20:46:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:45 INFO - 'LOGNAME': 'cltbld', 20:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:45 INFO - 'MOZ_NO_REMOTE': '1', 20:46:45 INFO - 'NO_EM_RESTART': '1', 20:46:45 INFO - 'PAGER': '/bin/cat', 20:46:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:45 INFO - 'PWD': '/builds/slave/test', 20:46:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:45 INFO - 'SHELL': '/bin/bash', 20:46:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m0E0eugPUG/Listeners', 20:46:45 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 20:46:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:45 INFO - 'USER': 'cltbld', 20:46:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:45 INFO - 'XPC_FLAGS': '0x0', 20:46:45 INFO - 'XPC_SERVICE_NAME': '0', 20:46:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:46:46 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-h5Sp6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:46:46 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-_cDRbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:46:46 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-fXfMHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:46:46 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-B9xsIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:46:46 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-w0RKUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:46:46 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-hP6Q0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:46:46 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-rDi5oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:46:46 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-LqxC0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:46:47 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-4O02QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:46:47 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-wI7SIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:46:47 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-bTQrYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:46:47 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-wzVB7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:46:47 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-a7Gnir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:46:47 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-DCvZdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:47 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-WVpvxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:46:47 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-LiO06e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:46:47 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-5Cu6Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:46:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:46:47 INFO - Running setup.py install for manifestparser 20:46:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:46:48 INFO - Running setup.py install for mozcrash 20:46:48 INFO - Running setup.py install for mozdebug 20:46:48 INFO - Running setup.py install for mozdevice 20:46:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:46:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:46:48 INFO - Running setup.py install for mozfile 20:46:48 INFO - Running setup.py install for mozhttpd 20:46:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:46:48 INFO - Running setup.py install for mozinfo 20:46:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:46:48 INFO - Running setup.py install for mozInstall 20:46:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:46:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:46:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:46:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:46:49 INFO - Running setup.py install for mozleak 20:46:49 INFO - Running setup.py install for mozlog 20:46:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:46:49 INFO - Running setup.py install for moznetwork 20:46:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:46:49 INFO - Running setup.py install for mozprocess 20:46:49 INFO - Running setup.py install for mozprofile 20:46:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:46:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:46:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:46:49 INFO - Running setup.py install for mozrunner 20:46:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:46:50 INFO - Running setup.py install for mozscreenshot 20:46:50 INFO - Running setup.py install for moztest 20:46:50 INFO - Running setup.py install for mozversion 20:46:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:46:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:46:50 INFO - Cleaning up... 20:46:50 INFO - Return code: 0 20:46:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:50 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')]} 20:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:50 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')]} 20:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:50 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 0x10336fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd430c82870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103213d30>, '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 0x103037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10320ab20>, '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.oVD7WUcXKt/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.m0E0eugPUG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 20:46:50 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 20:46:50 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 20:46:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oVD7WUcXKt/Render', 20:46:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:50 INFO - 'HOME': '/Users/cltbld', 20:46:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:50 INFO - 'LOGNAME': 'cltbld', 20:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:50 INFO - 'MOZ_NO_REMOTE': '1', 20:46:50 INFO - 'NO_EM_RESTART': '1', 20:46:50 INFO - 'PAGER': '/bin/cat', 20:46:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:50 INFO - 'PWD': '/builds/slave/test', 20:46:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:50 INFO - 'SHELL': '/bin/bash', 20:46:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m0E0eugPUG/Listeners', 20:46:50 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 20:46:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:50 INFO - 'USER': 'cltbld', 20:46:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:50 INFO - 'XPC_FLAGS': '0x0', 20:46:50 INFO - 'XPC_SERVICE_NAME': '0', 20:46:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:46:50 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-T0JwYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:46:50 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)) 20:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:46:50 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-BdzuWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:46:50 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)) 20:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:46:50 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-BK5rDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:46:51 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)) 20:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:46:51 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-pbHiwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:46:51 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)) 20:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:46:51 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-mXZhdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:46:51 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)) 20:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:46:51 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-i_Go0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:46:51 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)) 20:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:46:51 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-sf7fuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:46:51 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)) 20:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:46:51 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-GtNbVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:46:51 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)) 20:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:46:51 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-bbLbXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:46:51 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)) 20:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:46:51 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-UR07Uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:46:51 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)) 20:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:46:51 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-g9h5oY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:46:51 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)) 20:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:46:51 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Ydz8mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:46:52 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)) 20:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:46:52 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-xY0czM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:46:52 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)) 20:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:46:52 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-FTIEsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:46:52 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)) 20:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:52 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-xpcznR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:52 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)) 20:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:46:52 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-tRKmh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:46:52 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)) 20:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:46:52 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-_dSBrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:46:52 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)) 20:46:52 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)) 20:46:52 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)) 20:46:52 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)) 20:46:52 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)) 20:46:52 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)) 20:46:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:46:52 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 20:46:52 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 20:46:52 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 20:46:52 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 20:46:52 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 20:46:52 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 20:46:54 INFO - Downloading blessings-1.6.tar.gz 20:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:46:54 INFO - Installing collected packages: blessings 20:46:54 INFO - Running setup.py install for blessings 20:46:55 INFO - Successfully installed blessings 20:46:55 INFO - Cleaning up... 20:46:55 INFO - Return code: 0 20:46:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:55 INFO - Reading from file tmpfile_stdout 20:46:55 INFO - Current package versions: 20:46:55 INFO - blessings == 1.6 20:46:55 INFO - blobuploader == 1.2.4 20:46:55 INFO - docopt == 0.6.1 20:46:55 INFO - manifestparser == 1.1 20:46:55 INFO - mozInstall == 1.12 20:46:55 INFO - mozcrash == 0.16 20:46:55 INFO - mozdebug == 0.1 20:46:55 INFO - mozdevice == 0.48 20:46:55 INFO - mozfile == 1.2 20:46:55 INFO - mozhttpd == 0.7 20:46:55 INFO - mozinfo == 0.9 20:46:55 INFO - mozleak == 0.1 20:46:55 INFO - mozlog == 3.1 20:46:55 INFO - moznetwork == 0.27 20:46:55 INFO - mozprocess == 0.22 20:46:55 INFO - mozprofile == 0.28 20:46:55 INFO - mozrunner == 6.11 20:46:55 INFO - mozscreenshot == 0.1 20:46:55 INFO - mozsystemmonitor == 0.0 20:46:55 INFO - moztest == 0.7 20:46:55 INFO - mozversion == 1.4 20:46:55 INFO - psutil == 3.1.1 20:46:55 INFO - requests == 1.2.3 20:46:55 INFO - wsgiref == 0.1.2 20:46:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:55 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 0x10336fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd430c82870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103213d30>, '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 0x103037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10320ab20>, '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.oVD7WUcXKt/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.m0E0eugPUG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 20:46:55 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 20:46:55 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 20:46:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oVD7WUcXKt/Render', 20:46:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:55 INFO - 'HOME': '/Users/cltbld', 20:46:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:55 INFO - 'LOGNAME': 'cltbld', 20:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:55 INFO - 'MOZ_NO_REMOTE': '1', 20:46:55 INFO - 'NO_EM_RESTART': '1', 20:46:55 INFO - 'PAGER': '/bin/cat', 20:46:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:55 INFO - 'PWD': '/builds/slave/test', 20:46:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:55 INFO - 'SHELL': '/bin/bash', 20:46:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m0E0eugPUG/Listeners', 20:46:55 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 20:46:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:55 INFO - 'USER': 'cltbld', 20:46:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:55 INFO - 'XPC_FLAGS': '0x0', 20:46:55 INFO - 'XPC_SERVICE_NAME': '0', 20:46:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:55 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)) 20:46:55 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)) 20:46:55 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)) 20:46:55 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)) 20:46:55 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)) 20:46:55 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)) 20:46:55 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)) 20:46:55 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)) 20:46:55 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)) 20:46:55 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)) 20:46:55 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)) 20:46:55 INFO - Cleaning up... 20:46:55 INFO - Return code: 0 20:46:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:55 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 0x10336fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd430c82870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103213d30>, '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 0x103037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10320ab20>, '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.oVD7WUcXKt/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.m0E0eugPUG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 20:46:55 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 20:46:55 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 20:46:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oVD7WUcXKt/Render', 20:46:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:55 INFO - 'HOME': '/Users/cltbld', 20:46:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:55 INFO - 'LOGNAME': 'cltbld', 20:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:55 INFO - 'MOZ_NO_REMOTE': '1', 20:46:55 INFO - 'NO_EM_RESTART': '1', 20:46:55 INFO - 'PAGER': '/bin/cat', 20:46:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:55 INFO - 'PWD': '/builds/slave/test', 20:46:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:55 INFO - 'SHELL': '/bin/bash', 20:46:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m0E0eugPUG/Listeners', 20:46:55 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 20:46:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:55 INFO - 'USER': 'cltbld', 20:46:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:55 INFO - 'XPC_FLAGS': '0x0', 20:46:55 INFO - 'XPC_SERVICE_NAME': '0', 20:46:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:56 INFO - Downloading/unpacking jsonschema 20:46:56 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 20:46:56 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 20:46:56 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 20:46:56 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 20:46:56 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 20:46:56 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 20:46:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:46:58 INFO - Downloading/unpacking functools32 (from jsonschema) 20:46:58 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 20:46:58 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 20:46:58 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 20:46:58 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 20:46:58 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 20:46:58 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 20:46:58 INFO - Downloading functools32-3.2.3-2.tar.gz 20:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:46:58 INFO - warning: no files found matching '*.txt' 20:46:58 INFO - no previously-included directories found matching 'build' 20:46:58 INFO - no previously-included directories found matching 'dist' 20:46:58 INFO - no previously-included directories found matching '.git*' 20:46:58 INFO - Installing collected packages: jsonschema, functools32 20:46:58 INFO - Running setup.py install for functools32 20:46:59 INFO - warning: no files found matching '*.txt' 20:46:59 INFO - no previously-included directories found matching 'build' 20:46:59 INFO - no previously-included directories found matching 'dist' 20:46:59 INFO - no previously-included directories found matching '.git*' 20:46:59 INFO - Successfully installed jsonschema functools32 20:46:59 INFO - Cleaning up... 20:46:59 INFO - Return code: 0 20:46:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:46: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')]} 20:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46: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')]} 20:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10336fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033764c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd430c82870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103213d30>, '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 0x103037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10320ab20>, '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.oVD7WUcXKt/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.m0E0eugPUG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 20:46:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:46:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oVD7WUcXKt/Render', 20:46:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:59 INFO - 'HOME': '/Users/cltbld', 20:46:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:59 INFO - 'LOGNAME': 'cltbld', 20:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:59 INFO - 'MOZ_NO_REMOTE': '1', 20:46:59 INFO - 'NO_EM_RESTART': '1', 20:46:59 INFO - 'PAGER': '/bin/cat', 20:46:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:59 INFO - 'PWD': '/builds/slave/test', 20:46:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:59 INFO - 'SHELL': '/bin/bash', 20:46:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m0E0eugPUG/Listeners', 20:46:59 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 20:46:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:59 INFO - 'USER': 'cltbld', 20:46:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:59 INFO - 'XPC_FLAGS': '0x0', 20:46:59 INFO - 'XPC_SERVICE_NAME': '0', 20:46:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:59 INFO - Downloading/unpacking flake8 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:47:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:47:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:47: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 20:47: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 20:47: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 20:47: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 20:47: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 20:47: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 20:47:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:47:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:47:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:47:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:47:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:47:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:47:02 INFO - no previously-included directories found matching 'docs/_build' 20:47:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:47:03 INFO - Running setup.py install for pep8 20:47:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:47:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:47:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:47:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:47:03 INFO - no previously-included directories found matching 'docs/_build' 20:47:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:47:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:47:03 INFO - Cleaning up... 20:47:03 INFO - Return code: 0 20:47:03 INFO - Running post-action listener: _resource_record_post_action 20:47:03 INFO - Running post-action listener: _start_resource_monitoring 20:47:03 INFO - Starting resource monitoring. 20:47:03 INFO - ##### 20:47:03 INFO - ##### Running install step. 20:47:03 INFO - ##### 20:47:03 INFO - Running pre-action listener: _resource_record_pre_action 20:47:03 INFO - Running main action method: install 20:47:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:47:03 INFO - Reading from file tmpfile_stdout 20:47:03 INFO - Detecting whether we're running mozinstall >=1.0... 20:47:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:47:03 INFO - Reading from file tmpfile_stdout 20:47:03 INFO - Output received: 20:47:03 INFO - Usage: mozinstall [options] installer 20:47:03 INFO - Options: 20:47:03 INFO - -h, --help show this help message and exit 20:47:03 INFO - -d DEST, --destination=DEST 20:47:03 INFO - Directory to install application into. [default: 20:47:03 INFO - "/builds/slave/test"] 20:47:03 INFO - --app=APP Application being installed. [default: firefox] 20:47:03 INFO - mkdir: /builds/slave/test/build/application 20:47:03 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'] 20:47:03 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 20:47:37 INFO - Reading from file tmpfile_stdout 20:47:37 INFO - Output received: 20:47:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:47:37 INFO - Running post-action listener: _resource_record_post_action 20:47:37 INFO - ##### 20:47:37 INFO - ##### Running run-tests step. 20:47:37 INFO - ##### 20:47:37 INFO - Running pre-action listener: _resource_record_pre_action 20:47:37 INFO - Running main action method: run_tests 20:47:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:47:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:47:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:47:37 INFO - 2016-03-02 20:47:37.737 screenresolution[1644:8267] starting screenresolution argv=screenresolution get 20:47:37 INFO - 2016-03-02 20:47:37.739 screenresolution[1644:8267] Display 0: 1600x1200x32@60 20:47:37 INFO - 2016-03-02 20:47:37.745 screenresolution[1645:8269] starting screenresolution argv=screenresolution list 20:47:37 INFO - Available Modes on Display 0 20:47:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:47:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:47:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:47:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:47:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:47:37 INFO - Intel Iris: 20:47:37 INFO - Chipset Model: Intel Iris 20:47:37 INFO - Type: GPU 20:47:37 INFO - Bus: Built-In 20:47:37 INFO - VRAM (Dynamic, Max): 1536 MB 20:47:37 INFO - Vendor: Intel (0x8086) 20:47:37 INFO - Device ID: 0x0a2e 20:47:37 INFO - Revision ID: 0x0009 20:47:37 INFO - Displays: 20:47:37 INFO - Display: 20:47:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:47:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:47:37 INFO - Display Serial Number: 1600x1200 60 20:47:37 INFO - Main Display: Yes 20:47:37 INFO - Mirror: Off 20:47:37 INFO - Online: Yes 20:47:37 INFO - Rotation: Supported 20:47:37 INFO - Return code: 0 20:47:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:47:37 INFO - Python 2.7.3 20:47:37 INFO - Return code: 0 20:47:37 INFO - grabbing minidump binary from tooltool 20:47:37 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')]} 20:47:37 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 0x103213d30>, '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 0x103037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10320ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:47:37 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 20:47:37 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 20:47:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:47:38 INFO - Return code: 0 20:47:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:47:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:47:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:47:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:47:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:47:39 INFO - Return code: 0 20:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0067', '--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 20:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0067 --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 20:47:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oVD7WUcXKt/Render', 20:47:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:47:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:47:39 INFO - 'HOME': '/Users/cltbld', 20:47:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:47:39 INFO - 'LOGNAME': 'cltbld', 20:47:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:47:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:39 INFO - 'MOZ_NO_REMOTE': '1', 20:47:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:47:39 INFO - 'NO_EM_RESTART': '1', 20:47:39 INFO - 'PAGER': '/bin/cat', 20:47:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:39 INFO - 'PWD': '/builds/slave/test', 20:47:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:47:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:47:39 INFO - 'SHELL': '/bin/bash', 20:47:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m0E0eugPUG/Listeners', 20:47:39 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 20:47:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:47:39 INFO - 'USER': 'cltbld', 20:47:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:47:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:39 INFO - 'XPC_FLAGS': '0x0', 20:47:39 INFO - 'XPC_SERVICE_NAME': '0', 20:47:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:47:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0067', '--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 20:47:39 INFO - mozversion application_buildid: 20160302195121 20:47:39 INFO - mozversion application_changeset: 38d23f0168980b27bb88bf20a8cba7f907bc495e 20:47:39 INFO - mozversion application_display_name: Nightly 20:47:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:47:39 INFO - mozversion application_name: Firefox 20:47:39 INFO - mozversion application_remotingname: firefox 20:47:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:47:39 INFO - mozversion application_vendor: Mozilla 20:47:39 INFO - mozversion application_version: 47.0a1 20:47:39 INFO - mozversion platform_buildid: 20160302195121 20:47:39 INFO - mozversion platform_changeset: 38d23f0168980b27bb88bf20a8cba7f907bc495e 20:47:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:47:39 INFO - mozversion platform_version: 47.0a1 20:47:39 INFO - using testdate: 1456980459 20:47:39 INFO - actual date: 1456980459 20:47:39 INFO - starting webserver on 'localhost:49281' 20:47:39 INFO - SUITE-START | Running 2 tests 20:47:39 INFO - TEST-START | dromaeo_css 20:47:39 INFO - operating with platform_type : mac_ 20:47:39 INFO - Initialising browser for dromaeo_css test... 20:47:39 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpCJ1vVF/profile http://localhost:49281/getInfo.html) 20:47:42 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 20:47:42 INFO - PROCESS | 1663 | colorDepth:24 20:47:42 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 20:47:42 INFO - PROCESS | 1663 | __metrics 20:47:42 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 20:47:42 INFO - TEST-INFO | 1663: exit 0 20:47:42 INFO - Browser initialized. 20:47:42 INFO - Running cycle 1/1 for dromaeo_css test... 20:47:43 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpCJ1vVF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:47:55 INFO - PROCESS | 1667 | RSS: Main: 254955520 20:47:55 INFO - PROCESS | 1667 | 20:48:44 INFO - PROCESS | 1667 | 1456980524816 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] 20:50:55 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49281/tests/dromaeo/cssquery-ext.html) 20:50:56 INFO - PROCESS | 1667 | RSS: Main: 268427264 20:50:56 INFO - PROCESS | 1667 | 20:53:58 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-ext.html (next: http://localhost:49281/tests/dromaeo/cssquery-jquery.html) 20:53:59 INFO - PROCESS | 1667 | RSS: Main: 281366528 20:53:59 INFO - PROCESS | 1667 | 20:57:00 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49281/tests/dromaeo/cssquery-mootools.html) 20:57:01 INFO - PROCESS | 1667 | RSS: Main: 281243648 20:57:01 INFO - PROCESS | 1667 | 21:00:03 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49281/tests/dromaeo/cssquery-prototype.html) 21:00:03 INFO - PROCESS | 1667 | RSS: Main: 283541504 21:00:03 INFO - PROCESS | 1667 | 21:03:06 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49281/tests/dromaeo/cssquery-yui.html) 21:03:07 INFO - PROCESS | 1667 | RSS: Main: 286851072 21:03:07 INFO - PROCESS | 1667 | 21:06:09 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-yui.html (next: http://localhost:49281/tests/dromaeo/cssquery-dojo.html) 21:06:09 INFO - PROCESS | 1667 | RSS: Main: 288882688 21:06:09 INFO - PROCESS | 1667 | 21:06:09 INFO - PROCESS | 1667 | __start_tp_report 21:06:09 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 21:06:09 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 21:06:09 INFO - PROCESS | 1667 | |i|pagename|runs| 21:06:09 INFO - PROCESS | 1667 | |0;dojo.html;3358.7145092667124;3590.6050334463202;3617.891463256103;3619.5475565554307;3634.727395445342;5751.654900705956;5818.156367326735;5828.3297420796625;5834.941650583492;5850.76596936122;5691.715414229293;5729.226554415152;5810.738516766745;5832.708364581775;6001.549883758714;5224.973875130629;5266.3153790007245;5284.392294886099;5302.2311764794085;5326.360836699601;635.6055808546092;5183.998088848644;5271.393789714193;5295.629305948585;5345.812896548621;5215.348081489833;5215.765290561933;5226.5557427618505;5251.081060814361;5307.124324486455;4092.774897380643;4496.8875778105485;5164.664296820694;5280.049591073605;5323.600729945269;4983.6013118950395;5087.821926232601;5183.377994640668;5232.843014709565;5301.549368303698;5003;5193.324867767166;5204.791808327663;5495.477929596682;5641.605087643867;5960.880782384372;6104.15601054772;6149.5080393568405;6283.403076707706;6286.779962701329;6181.258249010102;6253.437190652818;6266.78066267683;6274.1843560336865;6284.5600807943465;5164.2253661950635;5648.717564121777;5858.355580886099;5899.233099697098;5910.261217347832;6177.505799536027;6262.874742505124;6299.590526615755;6311.96844015777;6326.778562750282;6179.104029915727;6206.255249370104;6223.3465486123305;6225.3774622537385;6228.937710622836;6208.565400422018;6250.6874656267;6254;6265.561410701207;6279.905801412982;6130.386961303834;6170.167027451326;6207.875842483125;6261.24865016201;6308;6117.204763380732;6165.815025549241;6282.937170628235;6300.369963003663;6312.52656050798;4540.636749060067;4954.455009948902;4983;4983.152864013126;5006.824761133415;4393.406890069864;4413.889652758707;4473;4476.776161191928;4517.887052823706;5756.481916627524;5756.597038207369;5771.422857714279;5800.245968024215;5813.563982701315;6290.21372328459;6314.905276420765;6319.747210111544;6322.178116844781;6326.335734747785;5691.146328050825;5782.132680097935;5864.970675146682;5868;5919.881602367928;5430.755615997289;5446.918296225481;5455.345358556999;5456.7544460499375;5457.945420545744;6229.2524897012645;6336.746530138835;6367.968160159169;6369.0764839099;6376.202974628079;6201.875962480635;6234.345393733593;6287.717052732546;6288.27684816252;6299.023651334051;5400.946815370965;6230.376962303733;6280.27776805655;6292.27638821523;6345.333739957238;6026.15633811258;6106.096658337741;6248.843778905563;6249.218847644044;6296.212973378328;6196.10156527292;6260.874782504416;6273.121762953099;6315.431611155018;6322.683865806784;6084.574079814371;6130.264368275835;6142.232220972379;6144.354842741448;6176.969115154396;4891.584215341736;6045.667488288186;6141.048137538689;6160.507159427325;6389.977603583405;5872.383399743137;5935.258092738408;6028.608140470856;6075.513958883367;6095.085737139465;6125.264968203844;6189.535784816067;6217.937820621736;6225.564210505221;6230.906536401867;5897.115432685132;6015.819525414245;6051.697415129138;6064.818055458343;6086.421789929949 21:06:09 INFO - PROCESS | 1667 | |1;ext.html;464.8373069425699;500.90733214355345;562.8489738484798;638.1353266324131;643.0290261704828;36878.631213687855;37160.62839371602;37402.81298593503;37450.063748406305;37487.06282342943;38164.427533586946;38440;38609;38652.613473865254;38654.45382184709;9334.719958401241;9501.80996380072;9522.285828562852;9524.952375238114;9574.329796914219;9358.953205233964;9625.326227164067;9634.421934683907;9638;9654.565544550513;9576.61139134825;9639.421634701941;9662.855057174149;9664.80670386592;9686.273529485281;8502.872456913152;9477.857832132524;9530.285228607847;9597.280203984728;9616.567254473566;9359.110884465965;9433.90566094344;9474.905250947471;9476.052394760538;9484.19384352331;31568.842155789305;38080.80959595212;38439;38479.80760096209;38615;3042.4827779277352;3074.3851229753914;3224.7365112053753;3766.5856755756845;3901.0247438140464;27201.863990680118;27246.591301130302;27349;27434.5884811728;27897.58153627697;2685.0736495909077;2725.38678797271;2736.7821319512823;2818.591304260871;2823.632927719404;321940;384525;390113;392795;394514.02742986387;44400.77799611046;45103.54896450994;62717;63415.36584634187;63485;43886.56113438825;44641;45052.54947450549;45220.09559808786;45303;15259.008164469275;15278.31247593861;15305.6173595661;15541;15573;12324.938375308066;12467;12494.81257781134;12499.187552809039;12537.122401431994;12140.575079872162;12636.30500322491;13226.603201903958;14075.225862577656;14423.78364324536;6352.809415717536;6454.419102280817;6459.580127291711;6461.547691661539;6513.2509761377105;819.336337566573;926.9212116970133;963.633819148719;1048.2714513413105;1084.3493903657743;21857.781422185573;25845.870770646026;27568.724312756614;27748;28993.275168120967;887.1616322575104;938.8732521109563;1044.3264094658903;1094.414488248783;1181.196786185385;14433.134011959317;14665.56003319902;14818.40726370933;14865.777013344808;14941.551753447415;424358;493726;498756;499550;504190;56856.43143568511;57115.714421428456;57403.71298143482;57678.134827977614;57726.7113664429;1408.2254759882023;1418.1278513713992;1442.5600191941348;1453.4404254362146;1459.6277949123119;28685.995990140244;29074.127776166748;29103.272418189714;29348;29477.85261073681;50964.49035509597;54053;54831.451685482636;55742.88514229774;55942.720286398304;473132;475100.62449687533;481291;481874.5906270446;483258;35966.820165899;42475.93810154771;43508.912277193325;43727.78136109299;44058;45374.092518150115;45730.54269457263;45731.31403029024;45776.31335529903;46087.308690370344;35790.74732384354;36436.81781591075;37650.246995060494;37864;38470;37074.62925370712;37413.625863742105;37649.247015058994;37708;38105.42841857319;34763;34925.825370874;35990.4601430984;36853.44719829151;37750;29996.550051748804;31520.211994700316;31945;33213;33350.83272085562;23674.881625591763;24031.759682402953;24722.381940451633;25185;25223.62164567496 21:06:09 INFO - PROCESS | 1667 | |2;jquery.html;349.3327744008942;359.31729713544263;359.91541987632917;360.9963900360996;362.4219370104685;14306.713865722679;15937.362505499796;16149.43476978306;19171.520711982208;20702.48243793904;18668.719969200472;19196.71204931927;19243.71134432981;19285.614287714237;19496.025198740077;5298.682079075248;5538.418466061066;5767.625104368223;5799.971000144993;6590.406863382294;6463.192100987377;6590.670466476681;6603;6614.173228346457;6621.404073633372;6229.626222426647;6441.645709485976;6455.774047908324;6475.061116138158;6540.313267106957;6344.953082741342;6373.235211774593;6379.840503987438;6380.872382552369;6399.328070552595;5484.890302193934;5531.502164805187;5617.38208797032;5634.098544232903;5649.0114230009995;20048.39854804358;25477.872610637012;25806.998136355127;25941.351466213306;25947.740522594722;2177.085624037908;2408.6025805742206;2411.867347295898;2666.3334166458385;2753.504369213541;14558.98087133901;14767;14774.89188310881;14813.259337033105;14956.775648365174;1272.1966661720353;1499.025633338328;1612.4517663994181;1630.2093484659931;1716.5708572856786;108934.45532772286;110642.44678776554;111276;112723.43638281839;113407;10404.479776011169;10615.363078215178;10627.893721062845;10804.1896857736;10862.619808306672;10759.408232547285;12006.759864802654;12611.747765044647;12893.613191604267;12919.095663303478;8416.284615807603;8527.23254907049;8572.971243450826;8589.398742088119;8657.783555411164;8777.166169214042;8860.601272942733;8873.201411872962;8907.777305567282;8948.463092214488;5099.719515426687;6174.166487524127;6217.564770466024;6238.313785483593;6274.309825919146;1856.1021854106268;1859.191251805469;1860.451166905766;1882.5952420229717;1894.535838719495;712.184548691745;788.239349028179;896.3546246702364;932.1238036246043;985.3693636072919;18670.53323666892;19123.139458724392;20487.38537843867;20723.27468538594;20782.688259676117;929.419113054341;953.1564565359706;969.3699095587924;980.4999450280266;985.9704208873745;8433.030201526903;9005.729828105168;11024.173187011007;11155.665330040112;11171.32972021665;577266;594123;604681;610359;617990;80591;102771;105008.47495762473;105561;107394;874.7681864305964;1010.5604062232952;1033.8811036730722;1037.2479952034714;1039.8908114647852;18562.907185463988;18564.907175464035;18606;18636.906815465834;18815.529611759815;46639.76680116577;48913;49099.018019638694;49238.01523969429;49329;68840.31159688339;68914.31085689079;69124.61750764855;69284;70018.94971575329;6439.420452159328;7810.9218907812465;8147.674093036212;8153.877691834508;8258.25675689191;9441.905580944103;10812.243142979916;12541.498340066295;13037.804432933324;13373.866261337262;10794.514246858753;11263.66209013731;11311.830322545333;11413.942930285295;11588.420578971187;11284.32294062359;11307.095432365555;11476.254043487146;11593.362365069665;12075.335856527623;11749.412529373669;11893.345865977455;11921.165518413974;12036.976856967256;12065.577704780291;7729.574873382018;7984.760457186294;8047.275745182962;8195.42632015777;8303.833923321621;6742.561733487308;7960.402969777406;8149.55091978184;8170.406770679898;8408.579571021546 21:06:09 INFO - PROCESS | 1667 | |3;mootools.html;1547.9690406191876;1548.5276990517896;1795.9191836367363;1907.7424547686066;1918.414883460544;7019.298070192978;8209.850620913077;8422.873656895152;8471.91528084719;8680.47917124972;6550;8457.15428457154;8514.318854491641;8628.91371086289;8872.467651940888;2407.7231118421387;2432.3067925641194;2441.633754936756;2441.890114944823;2449.730529641738;2362.0905951208824;2374.5844477216506;2401.0875867170453;2405.8195635327334;2410.4817464245184;2350.647402889572;2381.9047238110456;2392.4018995251186;2427.2475532584867;2429.259075981825;2370.2178281167257;2383.368407372039;2387.009391102699;2419.1532963462823;2448.5837407640565;2431.8905649245826;2457.2505385857307;2458.5943319352286;2462.4090218347646;2482.25532340299;8631.784205394853;8646;8677.349198810114;8701.60842762071;8702.347323950666;5109.054824857376;5252.816151434681;5253.185756207794;5267.815626453055;5287.312649355597;3505.7721248119046;3574.7140228781636;3577.874774382884;3613.765105268149;3640.5631324240994;1037.3237048415072;1058.5871510111062;1062.7502536903821;1067.359584249452;1067.5836423794726;11364.943175284154;11446.599369022044;11460.14048946324;11478.368689722061;11494.655160345203;4633.443986721615;4663.090697314059;4730.52694730531;4736.19484687597;4743.881402964885;9817.460039697742;9850.950745246228;9862.45756483386;9897.7030689078;9898.307118501636;5253.212018197224;5264.236685680555;5264.763085661154;5270.235815806764;5296.708681022581;4404.625606823456;4722.079194557028;4786.64100192487;4792.113459010095;4809.206480930678;3831.578526362098;3892.630200130983;3904.316744569689;3923.0388554804254;3943.507061617298;1289.9161554498928;1306.3207132291154;1315.5132600937714;1321.8281623388898;1323.219300612643;1278.9232646041266;1295.7149427126017;1306.9085164038615;1342.1410297409666;1347.9393427295795;8094.473859199134;8238.8352232955;8273.296769774637;8278.461899976483;8297.377696672773;1073.1790180511914;1123.6966019174777;1157.7105723569107;1166.7666466706692;1177.4289469607234;5141.897162056738;6082.452579267887;6154.907676384858;6252.155958945484;6263.342349053284;9987.30088893785;10605.151587872951;10615;10665.773436054798;10673.893261067446;10251.846222306522;10505.632302869362;10518.474076296308;10576.947115264375;10584.259101862795;7423;8081.717139900075;8186.2632363087605;8294.502329860228;8311.6675332986;7630.542167469969;7638.121616014229;7722.7297044603165;7732.845343092994;7750.186230445722;9264.44413335202;9527.809443811224;9560.043995600663;9606.183474404754;9656;9689.563969621244;9939.65211217604;9954.55204515784;10041.49792510357;10075.294729368874;5265.2365407015;6725.125733654593;6940.514164008471;6956.234814170539;7080.645967701491;8096.230858068474;8145.144759800136;8161.877571836546;8162.83674326522;8171.5505647189975;7160.713571457083;7213.9278607213255;7252.347288744038;7321.670524826289;7368.889466658112;7009.334113259232;7076.823079423056;7149.034880291094;7197.496175267681;7267;7417;7555.13115991668;7579.810504737426;7601.201873803392;7604.771856844303;6906;6954.721811127498;6969.6515174242095;6981.546199497219;7004.194517630538;6886.48351373659;7039.54242974205;7039.788806335818;7045.154581450259;7085.334946287721 21:06:09 INFO - PROCESS | 1667 | |4;prototype.html;303.6538346285234;321.08490801216533;323.687641426024;327.7967660050768;331.54909323320294;6783.186017677879;6852.55458395204;6880.208775990763;6881.518293719441;6909.827254318645;6731.663416829163;6810.284920083394;6853.2118806337285;6874.243833178346;6883.483738719591;3968.6229808168177;4499.055198408339;4942.851714448554;5048.1670524363435;5076.441591424949;5036.798528058874;5052.0906236877345;5065.138926382506;5068.5691716204165;5124.461931497195;4076.429299898017;5079.847604571869;5086.237064440326;5088.974555127219;5099.923501147486;5061.696298222082;5082.186850103984;5091.61812864033;5108.4125325587665;5128;4332.523422423531;4333.133373325348;4334.869953901388;4350.477942646871;4353.5428779977965;6325.715342809584;6571.67141642916;6613.3056029117215;6615.966920165417;6661.968099729581;4636.698614590041;4741.19399702048;5129.743212912823;5490.670559766427;5842.737076831553;5827.592068555203;7308.232635573241;7317.670704818296;7325.853482930364;7344.632768361561;3817.503724515823;4641.396618439615;4654.092451971833;4654.115718013567;4656.348111264392;7646.197149299354;7727.690892364299;7744.883826742604;7747.883781743279;7753.1083925348175;3452.4648679454726;4453.844115455943;4546.727196368229;4639.768011599474;4691.390119284471;4066.3087275163293;4657.115148121846;4763.809447622126;4777;4786.856394308176;5701.543876489954;5711.857203569944;5741.655500669973;5757.769689212469;5770.2498675171955;5943.970280148658;7333.816654583678;7342.3758980487255;7372.2259162788205;7375.778726638209;1564.765285207228;1611.2266112266177;1647.176411794103;1655.8426949439784;1678.479671301876;1040.5889673578895;1045.764702941832;1055.714956961616;1059.929471234059;1061.6125114333213;6708.228553716385;6748.089007983859;6754.594724316458;6763.458923286224;6766.086578311865;6179.660118693515;7552.282533159341;7559.924400756032;7582.317591416799;7600.049993750781;6719.496037797087;6719.596824190564;6733.93266067333;6740.561863478858;6754.3921047106;3120.625524937022;3946.506686664167;3985.20295940813;3991.461152744342;4017.91964160721;7736.845263094707;7744.225577442324;8068.8300196472355;8108.918910810817;8136.918630813734;8021.27808497238;8030.357571394275;8034.276915077671;8054.275115239657;8057.0734365548715;6579.440747536417;7982.281594656509;8061.435699500978;8084.717034903751;8139.959300203461;7242.493025488376;7611.238876112345;7615.847683046197;7716.305532502101;7732.420068494773;7448.776536703907;7463.067116610424;7515.286047825448;7603.429742769204;7631.618419079135;8012.959935200287;8059.098724459072;8065.717699880476;8071.838563228585;8074.273315401642;4734.55021772931;4770;4781.497942716104;4809.807607695653;4817.325574419654;7457.888131678138;7589;7629.6566654499575;7662.655180516778;7689.730859419893;7176.959340895436;7334.669939852826;7379.963100184465;7401.555906645618;7402.703891844266;6220.502359811114;7397.186309506058;7409.555426674417;7414.555126692416;7458.589777562286;7047.682854271673;7161.319674630901;7179.605121718356;7192.992980982771;7226.494145409771;6228.4705800007505;7216.170140433707;7371.889421658787;7445.627718614156;7450.888236676563;7205.639718014183;7222.133343998754;7240.782776516713;7251.746188883364;7278 21:06:09 INFO - PROCESS | 1667 | |5;yui.html;695.3950063444804;717.7523754304763;729.9197088320285;739.711512510121;741.6328917185987;14618.48835290765;14708.411663533472;14770.778438323421;14786.852131478681;14810.851891481081;12813.807792883114;12830.486780528767;12843.35783210838;12850.421731022103;12867.54963576275;693.4383149648776;842.465034702965;842.7808769719855;864.0409145848104;871.3029576338935;852.765489490392;854.679495189304;863.7149740585592;864.6541383446609;865.9740207793776;915.514777168102;917.6054296652437;922.0502882031518;923.5890028937125;923.8429466990627;898.7842917699737;905.316486053029;911.3939230411768;913.7943962608426;916.5234078279291;654.7119267522274;655.4068567946016;669.581511555278;676.5298117808076;680.4930326906436;14269.357878895475;14346.354414051393;14371.71256574873;14429.567112986628;14450.205238711867;12391.62825115248;12517.311547864863;12584.119111662187;12726.554570590077;12784.360781960864;9925.851112233322;10012.799744005151;10069.395836249776;10093.747656308578;10371.377717336984;3441.174118211611;3468.9826550867338;3473.565804274466;3515.894523164284;3589.3180295743723;78975.42049159043;79670.20329796686;79773;80121.59939200267;80628.19371806324;9004.4337363851;9032.096790320915;9059.320550958704;9088.727338179866;9129.876758556824;20327;20555.691664625043;20575.691364629543;20603.58792824135;20642.17431302731;7371.741989030358;7465.141508726566;7466.552006879605;7558.697652093964;7644.541327520366;3453.7582369233915;3953.6244056814558;3975.4235635832642;3984.900377490586;3992.500937382827;3306.272620023591;3466.5666791651042;3468.497067925137;3493.5633045869267;3520.2959408117968;613.3253421236604;667.7095463473307;676.0602762160601;680.2143524229523;700.6286668065933;481.4905271972392;565.4147956864707;583.7635757518212;584.9356570777211;608.0484042473515;6089.512838972872;8128.349732021424;8374.330053595697;8480.915190848136;8677.349198810114;462.50280947981054;550.8292429346915;593.2506558549923;597.9043353063576;601.3265143039736;3598.514200582888;3757.774533527997;3789.5452545694143;3909.4526766252748;4027.7180597357906;79066;81868.18131818605;81943;82347.58826205951;82581.58709206416;69699.3030069703;70374.64812675904;71101.93347099797;71343.64328178325;71888.28111718816;62675.35921767063;63091;63117.36882631115;63545;63936.68031659812;7669.3864490841715;7674.8081297968;7675.53946763196;7699.883516889908;7711.38308935295;31323;45162.32256516089;45685.85785355393;46115.769421152676;46121.769391152826;59104.52238694067;59317.70341148267;59605.40394595999;60764.39235607764;61088.38911610827;9527.142557169887;9531.094546018117;9618.759531011781;9874.901250987397;9954.701358959242;10415.270931034755;10462.895371046496;10504;10665.9466702666;10967.341959482457;10050.09549140581;10081.899181008095;10103.898961010296;10314.226433017704;10938.289011214245;9193.310501712533;10192.082712555906;10230.437325947145;10477.895221047997;10537.894621053998;10056.748581285234;10084.445355505517;10292.433916134385;10339.017793309924;10368.844467333147;8534.573271336532;8544;8820.9498798406;8887.688930887389;8905.441547729251;9075.092490751136;9366.95316523413;9447.52762361893;9520.857187142337;9553.61785528571 21:06:09 INFO - PROCESS | 1667 | __end_tp_report 21:06:09 INFO - PROCESS | 1667 | __start_cc_report 21:06:09 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,339 21:06:09 INFO - PROCESS | 1667 | __end_cc_report 21:06:09 INFO - PROCESS | 1667 | __startTimestamp1456981569835__endTimestamp 21:06:09 INFO - PROCESS | 1667 | 21:06:09 INFO - PROCESS | 1667 | ------- Summary: start ------- 21:06:09 INFO - PROCESS | 1667 | Number of tests: 6 21:06:09 INFO - PROCESS | 1667 | 21:06:09 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5723.24 Median:6028.61 stddev:762.12 (12.6%) stddev-sans-first:741.54 21:06:09 INFO - PROCESS | 1667 | Values: 3358.7 3590.6 3617.9 3619.5 3634.7 5751.7 5818.2 5828.3 5834.9 5850.8 5691.7 5729.2 5810.7 5832.7 6001.5 5225.0 5266.3 5284.4 5302.2 5326.4 635.6 5184.0 5271.4 5295.6 5345.8 5215.3 5215.8 5226.6 5251.1 5307.1 4092.8 4496.9 5164.7 5280.0 5323.6 4983.6 5087.8 5183.4 5232.8 5301.5 5003.0 5193.3 5204.8 5495.5 5641.6 5960.9 6104.2 6149.5 6283.4 6286.8 6181.3 6253.4 6266.8 6274.2 6284.6 5164.2 5648.7 5858.4 5899.2 5910.3 6177.5 6262.9 6299.6 6312.0 6326.8 6179.1 6206.3 6223.3 6225.4 6228.9 6208.6 6250.7 6254.0 6265.6 6279.9 6130.4 6170.2 6207.9 6261.2 6308.0 6117.2 6165.8 6282.9 6300.4 6312.5 4540.6 4954.5 4983.0 4983.2 5006.8 4393.4 4413.9 4473.0 4476.8 4517.9 5756.5 5756.6 5771.4 5800.2 5813.6 6290.2 6314.9 6319.7 6322.2 6326.3 5691.1 5782.1 5865.0 5868.0 5919.9 5430.8 5446.9 5455.3 5456.8 5457.9 6229.3 6336.7 6368.0 6369.1 6376.2 6201.9 6234.3 6287.7 6288.3 6299.0 5400.9 6230.4 6280.3 6292.3 6345.3 6026.2 6106.1 6248.8 6249.2 6296.2 6196.1 6260.9 6273.1 6315.4 6322.7 6084.6 6130.3 6142.2 6144.4 6177.0 4891.6 6045.7 6141.0 6160.5 6390.0 5872.4 5935.3 6028.6 6075.5 6095.1 6125.3 6189.5 6217.9 6225.6 6230.9 5897.1 6015.8 6051.7 6064.8 6086.4 21:06:09 INFO - PROCESS | 1667 | 21:06:09 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:58974.47 Median:211497.50 stddev:119482.55 (56.5%) stddev-sans-first:119736.97 21:06:09 INFO - PROCESS | 1667 | Values: 464.8 500.9 562.8 638.1 643.0 36878.6 37160.6 37402.8 37450.1 37487.1 38164.4 38440.0 38609.0 38652.6 38654.5 9334.7 9501.8 9522.3 9525.0 9574.3 9359.0 9625.3 9634.4 9638.0 9654.6 9576.6 9639.4 9662.9 9664.8 9686.3 8502.9 9477.9 9530.3 9597.3 9616.6 9359.1 9433.9 9474.9 9476.1 9484.2 31568.8 38080.8 38439.0 38479.8 38615.0 3042.5 3074.4 3224.7 3766.6 3901.0 27201.9 27246.6 27349.0 27434.6 27897.6 2685.1 2725.4 2736.8 2818.6 2823.6 321940.0 384525.0 390113.0 392795.0 394514.0 44400.8 45103.5 62717.0 63415.4 63485.0 43886.6 44641.0 45052.5 45220.1 45303.0 15259.0 15278.3 15305.6 15541.0 15573.0 12324.9 12467.0 12494.8 12499.2 12537.1 12140.6 12636.3 13226.6 14075.2 14423.8 6352.8 6454.4 6459.6 6461.5 6513.3 819.3 926.9 963.6 1048.3 1084.3 21857.8 25845.9 27568.7 27748.0 28993.3 887.2 938.9 1044.3 1094.4 1181.2 14433.1 14665.6 14818.4 14865.8 14941.6 424358.0 493726.0 498756.0 499550.0 504190.0 56856.4 57115.7 57403.7 57678.1 57726.7 1408.2 1418.1 1442.6 1453.4 1459.6 28686.0 29074.1 29103.3 29348.0 29477.9 50964.5 54053.0 54831.5 55742.9 55942.7 473132.0 475100.6 481291.0 481874.6 483258.0 35966.8 42475.9 43508.9 43727.8 44058.0 45374.1 45730.5 45731.3 45776.3 46087.3 35790.7 36436.8 37650.2 37864.0 38470.0 37074.6 37413.6 37649.2 37708.0 38105.4 34763.0 34925.8 35990.5 36853.4 37750.0 29996.6 31520.2 31945.0 33213.0 33350.8 23674.9 24031.8 24722.4 25185.0 25223.6 21:06:09 INFO - PROCESS | 1667 | 21:06:09 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:33652.86 Median:354.33 stddev:99434.12 (28063.0%) stddev-sans-first:99681.61 21:06:09 INFO - PROCESS | 1667 | Values: 349.3 359.3 359.9 361.0 362.4 14306.7 15937.4 16149.4 19171.5 20702.5 18668.7 19196.7 19243.7 19285.6 19496.0 5298.7 5538.4 5767.6 5800.0 6590.4 6463.2 6590.7 6603.0 6614.2 6621.4 6229.6 6441.6 6455.8 6475.1 6540.3 6345.0 6373.2 6379.8 6380.9 6399.3 5484.9 5531.5 5617.4 5634.1 5649.0 20048.4 25477.9 25807.0 25941.4 25947.7 2177.1 2408.6 2411.9 2666.3 2753.5 14559.0 14767.0 14774.9 14813.3 14956.8 1272.2 1499.0 1612.5 1630.2 1716.6 108934.5 110642.4 111276.0 112723.4 113407.0 10404.5 10615.4 10627.9 10804.2 10862.6 10759.4 12006.8 12611.7 12893.6 12919.1 8416.3 8527.2 8573.0 8589.4 8657.8 8777.2 8860.6 8873.2 8907.8 8948.5 5099.7 6174.2 6217.6 6238.3 6274.3 1856.1 1859.2 1860.5 1882.6 1894.5 712.2 788.2 896.4 932.1 985.4 18670.5 19123.1 20487.4 20723.3 20782.7 929.4 953.2 969.4 980.5 986.0 8433.0 9005.7 11024.2 11155.7 11171.3 577266.0 594123.0 604681.0 610359.0 617990.0 80591.0 102771.0 105008.5 105561.0 107394.0 874.8 1010.6 1033.9 1037.2 1039.9 18562.9 18564.9 18606.0 18636.9 18815.5 46639.8 48913.0 49099.0 49238.0 49329.0 68840.3 68914.3 69124.6 69284.0 70018.9 6439.4 7810.9 8147.7 8153.9 8258.3 9441.9 10812.2 12541.5 13037.8 13373.9 10794.5 11263.7 11311.8 11413.9 11588.4 11284.3 11307.1 11476.3 11593.4 12075.3 11749.4 11893.3 11921.2 12037.0 12065.6 7729.6 7984.8 8047.3 8195.4 8303.8 6742.6 7960.4 8149.6 8170.4 8408.6 21:06:09 INFO - PROCESS | 1667 | 21:06:09 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5930.54 Median:5258.72 stddev:3104.13 (59.0%) stddev-sans-first:3095.36 21:06:09 INFO - PROCESS | 1667 | Values: 1548.0 1548.5 1795.9 1907.7 1918.4 7019.3 8209.9 8422.9 8471.9 8680.5 6550.0 8457.2 8514.3 8628.9 8872.5 2407.7 2432.3 2441.6 2441.9 2449.7 2362.1 2374.6 2401.1 2405.8 2410.5 2350.6 2381.9 2392.4 2427.2 2429.3 2370.2 2383.4 2387.0 2419.2 2448.6 2431.9 2457.3 2458.6 2462.4 2482.3 8631.8 8646.0 8677.3 8701.6 8702.3 5109.1 5252.8 5253.2 5267.8 5287.3 3505.8 3574.7 3577.9 3613.8 3640.6 1037.3 1058.6 1062.8 1067.4 1067.6 11364.9 11446.6 11460.1 11478.4 11494.7 4633.4 4663.1 4730.5 4736.2 4743.9 9817.5 9851.0 9862.5 9897.7 9898.3 5253.2 5264.2 5264.8 5270.2 5296.7 4404.6 4722.1 4786.6 4792.1 4809.2 3831.6 3892.6 3904.3 3923.0 3943.5 1289.9 1306.3 1315.5 1321.8 1323.2 1278.9 1295.7 1306.9 1342.1 1347.9 8094.5 8238.8 8273.3 8278.5 8297.4 1073.2 1123.7 1157.7 1166.8 1177.4 5141.9 6082.5 6154.9 6252.2 6263.3 9987.3 10605.2 10615.0 10665.8 10673.9 10251.8 10505.6 10518.5 10576.9 10584.3 7423.0 8081.7 8186.3 8294.5 8311.7 7630.5 7638.1 7722.7 7732.8 7750.2 9264.4 9527.8 9560.0 9606.2 9656.0 9689.6 9939.7 9954.6 10041.5 10075.3 5265.2 6725.1 6940.5 6956.2 7080.6 8096.2 8145.1 8161.9 8162.8 8171.6 7160.7 7213.9 7252.3 7321.7 7368.9 7009.3 7076.8 7149.0 7197.5 7267.0 7417.0 7555.1 7579.8 7601.2 7604.8 6906.0 6954.7 6969.7 6981.5 7004.2 6886.5 7039.5 7039.8 7045.2 7085.3 21:06:09 INFO - PROCESS | 1667 | 21:06:09 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5930.94 Median:6737.25 stddev:1975.96 (29.3%) stddev-sans-first:1935.83 21:06:09 INFO - PROCESS | 1667 | Values: 303.7 321.1 323.7 327.8 331.5 6783.2 6852.6 6880.2 6881.5 6909.8 6731.7 6810.3 6853.2 6874.2 6883.5 3968.6 4499.1 4942.9 5048.2 5076.4 5036.8 5052.1 5065.1 5068.6 5124.5 4076.4 5079.8 5086.2 5089.0 5099.9 5061.7 5082.2 5091.6 5108.4 5128.0 4332.5 4333.1 4334.9 4350.5 4353.5 6325.7 6571.7 6613.3 6616.0 6662.0 4636.7 4741.2 5129.7 5490.7 5842.7 5827.6 7308.2 7317.7 7325.9 7344.6 3817.5 4641.4 4654.1 4654.1 4656.3 7646.2 7727.7 7744.9 7747.9 7753.1 3452.5 4453.8 4546.7 4639.8 4691.4 4066.3 4657.1 4763.8 4777.0 4786.9 5701.5 5711.9 5741.7 5757.8 5770.2 5944.0 7333.8 7342.4 7372.2 7375.8 1564.8 1611.2 1647.2 1655.8 1678.5 1040.6 1045.8 1055.7 1059.9 1061.6 6708.2 6748.1 6754.6 6763.5 6766.1 6179.7 7552.3 7559.9 7582.3 7600.0 6719.5 6719.6 6733.9 6740.6 6754.4 3120.6 3946.5 3985.2 3991.5 4017.9 7736.8 7744.2 8068.8 8108.9 8136.9 8021.3 8030.4 8034.3 8054.3 8057.1 6579.4 7982.3 8061.4 8084.7 8140.0 7242.5 7611.2 7615.8 7716.3 7732.4 7448.8 7463.1 7515.3 7603.4 7631.6 8013.0 8059.1 8065.7 8071.8 8074.3 4734.6 4770.0 4781.5 4809.8 4817.3 7457.9 7589.0 7629.7 7662.7 7689.7 7177.0 7334.7 7380.0 7401.6 7402.7 6220.5 7397.2 7409.6 7414.6 7458.6 7047.7 7161.3 7179.6 7193.0 7226.5 6228.5 7216.2 7371.9 7445.6 7450.9 7205.6 7222.1 7240.8 7251.7 7278.0 21:06:09 INFO - PROCESS | 1667 | 21:06:09 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:16839.50 Median:62883.18 stddev:23395.10 (37.2%) stddev-sans-first:23429.33 21:06:09 INFO - PROCESS | 1667 | Values: 695.4 717.8 729.9 739.7 741.6 14618.5 14708.4 14770.8 14786.9 14810.9 12813.8 12830.5 12843.4 12850.4 12867.5 693.4 842.5 842.8 864.0 871.3 852.8 854.7 863.7 864.7 866.0 915.5 917.6 922.1 923.6 923.8 898.8 905.3 911.4 913.8 916.5 654.7 655.4 669.6 676.5 680.5 14269.4 14346.4 14371.7 14429.6 14450.2 12391.6 12517.3 12584.1 12726.6 12784.4 9925.9 10012.8 10069.4 10093.7 10371.4 3441.2 3469.0 3473.6 3515.9 3589.3 78975.4 79670.2 79773.0 80121.6 80628.2 9004.4 9032.1 9059.3 9088.7 9129.9 20327.0 20555.7 20575.7 20603.6 20642.2 7371.7 7465.1 7466.6 7558.7 7644.5 3453.8 3953.6 3975.4 3984.9 3992.5 3306.3 3466.6 3468.5 3493.6 3520.3 613.3 667.7 676.1 680.2 700.6 481.5 565.4 583.8 584.9 608.0 6089.5 8128.3 8374.3 8480.9 8677.3 462.5 550.8 593.3 597.9 601.3 3598.5 3757.8 3789.5 3909.5 4027.7 79066.0 81868.2 81943.0 82347.6 82581.6 69699.3 70374.6 71101.9 71343.6 71888.3 62675.4 63091.0 63117.4 63545.0 63936.7 7669.4 7674.8 7675.5 7699.9 7711.4 31323.0 45162.3 45685.9 46115.8 46121.8 59104.5 59317.7 59605.4 60764.4 61088.4 9527.1 9531.1 9618.8 9874.9 9954.7 10415.3 10462.9 10504.0 10665.9 10967.3 10050.1 10081.9 10103.9 10314.2 10938.3 9193.3 10192.1 10230.4 10477.9 10537.9 10056.7 10084.4 10292.4 10339.0 10368.8 8534.6 8544.0 8820.9 8887.7 8905.4 9075.1 9367.0 9447.5 9520.9 9553.6 21:06:09 INFO - PROCESS | 1667 | -------- Summary: end -------- 21:06:09 INFO - PROCESS | 1667 | 21:06:10 INFO - TEST-INFO | 1667: exit 0 21:06:10 INFO - TEST-OK | dromaeo_css | took 1110947ms 21:06:10 INFO - TEST-START | kraken 21:06:10 INFO - operating with platform_type : mac_ 21:06:10 INFO - Initialising browser for kraken test... 21:06:10 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmprwvKWi/profile http://localhost:49281/getInfo.html) 21:06:13 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 21:06:13 INFO - PROCESS | 1676 | colorDepth:24 21:06:13 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 21:06:13 INFO - PROCESS | 1676 | __metrics 21:06:13 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 21:06:13 INFO - TEST-INFO | 1676: exit 0 21:06:13 INFO - Browser initialized. 21:06:13 INFO - Running cycle 1/1 for kraken test... 21:06:13 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmprwvKWi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:06:25 INFO - PROCESS | 1679 | RSS: Main: 253915136 21:06:25 INFO - PROCESS | 1679 | 21:06:28 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection) 21:06:29 INFO - PROCESS | 1679 | RSS: Main: 268357632 21:06:29 INFO - PROCESS | 1679 | 21:06:31 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-dft) 21:06:32 INFO - PROCESS | 1679 | RSS: Main: 276332544 21:06:32 INFO - PROCESS | 1679 | 21:06:35 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-fft) 21:06:36 INFO - PROCESS | 1679 | RSS: Main: 279564288 21:06:36 INFO - PROCESS | 1679 | 21:06:38 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator) 21:06:39 INFO - PROCESS | 1679 | RSS: Main: 282640384 21:06:39 INFO - PROCESS | 1679 | 21:06:41 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:06:41 INFO - PROCESS | 1679 | RSS: Main: 282882048 21:06:41 INFO - PROCESS | 1679 | 21:06:44 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom) 21:06:45 INFO - PROCESS | 1679 | RSS: Main: 281104384 21:06:45 INFO - PROCESS | 1679 | 21:06:47 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate) 21:06:48 INFO - PROCESS | 1679 | RSS: Main: 282091520 21:06:48 INFO - PROCESS | 1679 | 21:06:51 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial) 21:06:51 INFO - PROCESS | 1679 | RSS: Main: 282251264 21:06:51 INFO - PROCESS | 1679 | 21:06:53 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:06:53 INFO - PROCESS | 1679 | RSS: Main: 283893760 21:06:53 INFO - PROCESS | 1679 | 21:06:55 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:06:56 INFO - PROCESS | 1679 | RSS: Main: 282079232 21:06:56 INFO - PROCESS | 1679 | 21:06:58 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:06:59 INFO - PROCESS | 1679 | RSS: Main: 282337280 21:06:59 INFO - PROCESS | 1679 | 21:07:02 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:07:02 INFO - PROCESS | 1679 | RSS: Main: 282742784 21:07:02 INFO - PROCESS | 1679 | 21:07:05 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:07:05 INFO - PROCESS | 1679 | RSS: Main: 282525696 21:07:05 INFO - PROCESS | 1679 | 21:07:07 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49281/tests/kraken/driver.html?testName=ai-astar) 21:07:08 INFO - PROCESS | 1679 | RSS: Main: 285564928 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | __start_tp_report 21:07:08 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 21:07:08 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 21:07:08 INFO - PROCESS | 1679 | |i|pagename|runs| 21:07:08 INFO - PROCESS | 1679 | |0;ai-astar;117;107;109;113;114;126;114;117;116;114 21:07:08 INFO - PROCESS | 1679 | |1;audio-beat-detection;157;125;148;157;122;143;138;126;159;122 21:07:08 INFO - PROCESS | 1679 | |2;audio-dft;199;200;197;210;231;278;241;203;199;198 21:07:08 INFO - PROCESS | 1679 | |3;audio-fft;67;78;76;141;88;83;87;88;121;58 21:07:08 INFO - PROCESS | 1679 | |4;audio-oscillator;86;82;124;81;118;116;126;81;82;114 21:07:08 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;88;86;89;87;109;86;89;87;88;86 21:07:08 INFO - PROCESS | 1679 | |6;imaging-darkroom;95;96;95;101;95;96;95;95;94;95 21:07:08 INFO - PROCESS | 1679 | |7;imaging-desaturate;92;95;91;92;93;91;89;91;92;91 21:07:08 INFO - PROCESS | 1679 | |8;json-parse-financial;57;56;57;56;58;57;54;63;62;54 21:07:08 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;65;66;71;69;68;76;97;105;99;99 21:07:08 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;84;90;103;112;114;97;91;87;91;90 21:07:08 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;138;122;134;122;114;137;119;140;135;139 21:07:08 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;150;176;125;167;190;185;147;146;156;187 21:07:08 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;67;69;70;70;77;100;94;58;76;93 21:07:08 INFO - PROCESS | 1679 | __end_tp_report 21:07:08 INFO - PROCESS | 1679 | __start_cc_report 21:07:08 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,889 21:07:08 INFO - PROCESS | 1679 | __end_cc_report 21:07:08 INFO - PROCESS | 1679 | __startTimestamp1456981628042__endTimestamp 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | ------- Summary: start ------- 21:07:08 INFO - PROCESS | 1679 | Number of tests: 14 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:5.12 (4.5%) stddev-sans-first:5.36 21:07:08 INFO - PROCESS | 1679 | Values: 117.0 107.0 109.0 113.0 114.0 126.0 114.0 117.0 116.0 114.0 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:145.50 stddev:15.22 (10.5%) stddev-sans-first:14.80 21:07:08 INFO - PROCESS | 1679 | Values: 157.0 125.0 148.0 157.0 122.0 143.0 138.0 126.0 159.0 122.0 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:215.60 Median:206.50 stddev:26.70 (12.9%) stddev-sans-first:27.64 21:07:08 INFO - PROCESS | 1679 | Values: 199.0 200.0 197.0 210.0 231.0 278.0 241.0 203.0 199.0 198.0 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:88.70 Median:80.50 stddev:24.73 (30.7%) stddev-sans-first:24.95 21:07:08 INFO - PROCESS | 1679 | Values: 67.0 78.0 76.0 141.0 88.0 83.0 87.0 88.0 121.0 58.0 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:101.00 Median:81.00 stddev:19.96 (24.6%) stddev-sans-first:20.41 21:07:08 INFO - PROCESS | 1679 | Values: 86.0 82.0 124.0 81.0 118.0 116.0 126.0 81.0 82.0 114.0 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:87.50 stddev:6.95 (7.9%) stddev-sans-first:7.35 21:07:08 INFO - PROCESS | 1679 | Values: 88.0 86.0 89.0 87.0 109.0 86.0 89.0 87.0 88.0 86.0 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:95.00 stddev:1.95 (2.0%) stddev-sans-first:2.05 21:07:08 INFO - PROCESS | 1679 | Values: 95.0 96.0 95.0 101.0 95.0 96.0 95.0 95.0 94.0 95.0 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:91.70 Median:92.00 stddev:1.57 (1.7%) stddev-sans-first:1.66 21:07:08 INFO - PROCESS | 1679 | Values: 92.0 95.0 91.0 92.0 93.0 91.0 89.0 91.0 92.0 91.0 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:2.99 (5.2%) stddev-sans-first:3.17 21:07:08 INFO - PROCESS | 1679 | Values: 57.0 56.0 57.0 56.0 58.0 57.0 54.0 63.0 62.0 54.0 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:81.50 Median:73.50 stddev:16.32 (22.2%) stddev-sans-first:16.18 21:07:08 INFO - PROCESS | 1679 | Values: 65.0 66.0 71.0 69.0 68.0 76.0 97.0 105.0 99.0 99.0 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:95.90 Median:90.00 stddev:10.42 (11.6%) stddev-sans-first:10.12 21:07:08 INFO - PROCESS | 1679 | Values: 84.0 90.0 103.0 112.0 114.0 97.0 91.0 87.0 91.0 90.0 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:136.00 stddev:9.66 (7.1%) stddev-sans-first:9.80 21:07:08 INFO - PROCESS | 1679 | Values: 138.0 122.0 134.0 122.0 114.0 137.0 119.0 140.0 135.0 139.0 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:171.50 stddev:21.55 (12.6%) stddev-sans-first:22.35 21:07:08 INFO - PROCESS | 1679 | Values: 150.0 176.0 125.0 167.0 190.0 185.0 147.0 146.0 156.0 187.0 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:73.00 stddev:13.73 (18.8%) stddev-sans-first:14.04 21:07:08 INFO - PROCESS | 1679 | Values: 67.0 69.0 70.0 70.0 77.0 100.0 94.0 58.0 76.0 93.0 21:07:08 INFO - PROCESS | 1679 | -------- Summary: end -------- 21:07:08 INFO - PROCESS | 1679 | 21:07:08 INFO - TEST-INFO | 1679: exit 0 21:07:08 INFO - TEST-OK | kraken | took 58302ms 21:07:08 INFO - SUITE-END | took 1169s 21:07:09 INFO - Completed test suite (00:19:29) 21:07:09 INFO - Working with test: dromaeo_css 21:07:09 INFO - Generating results file: dromaeo_css 21:07:09 INFO - Working with test: kraken 21:07:09 INFO - Generating results file: kraken 21:07:09 INFO - javascript benchmark 21:07:09 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:07:09 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 21:07:09 INFO - process_Request line: dromaeo_css 7429.93 graph.html#tests=[[72,64,61]] 21:07:09 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:07:09 INFO - process_Request line: kraken 1541.70 graph.html#tests=[[232,64,61]] 21:07:09 INFO - RETURN: dromaeo_css: 7429.93 21:07:09 INFO - RETURN: kraken: 1541.70 21:07:09 INFO - javascript benchmark 21:07:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3358.7145092667124, 3590.6050334463202, 3617.891463256103, 3619.5475565554307, 3634.727395445342, 5751.654900705956, 5818.156367326735, 5828.3297420796625, 5834.941650583492, 5850.76596936122, 5691.715414229293, 5729.226554415152, 5810.738516766745, 5832.708364581775, 6001.549883758714, 5224.973875130629, 5266.3153790007245, 5284.392294886099, 5302.2311764794085, 5326.360836699601, 635.6055808546092, 5183.998088848644, 5271.393789714193, 5295.629305948585, 5345.812896548621, 5215.348081489833, 5215.765290561933, 5226.5557427618505, 5251.081060814361, 5307.124324486455, 4092.774897380643, 4496.8875778105485, 5164.664296820694, 5280.049591073605, 5323.600729945269, 4983.6013118950395, 5087.821926232601, 5183.377994640668, 5232.843014709565, 5301.549368303698, 5003.0, 5193.324867767166, 5204.791808327663, 5495.477929596682, 5641.605087643867, 5960.880782384372, 6104.15601054772, 6149.5080393568405, 6283.403076707706, 6286.779962701329, 6181.258249010102, 6253.437190652818, 6266.78066267683, 6274.1843560336865, 6284.5600807943465, 5164.2253661950635, 5648.717564121777, 5858.355580886099, 5899.233099697098, 5910.261217347832, 6177.505799536027, 6262.874742505124, 6299.590526615755, 6311.96844015777, 6326.778562750282, 6179.104029915727, 6206.255249370104, 6223.3465486123305, 6225.3774622537385, 6228.937710622836, 6208.565400422018, 6250.6874656267, 6254.0, 6265.561410701207, 6279.905801412982, 6130.386961303834, 6170.167027451326, 6207.875842483125, 6261.24865016201, 6308.0, 6117.204763380732, 6165.815025549241, 6282.937170628235, 6300.369963003663, 6312.52656050798, 4540.636749060067, 4954.455009948902, 4983.0, 4983.152864013126, 5006.824761133415, 4393.406890069864, 4413.889652758707, 4473.0, 4476.776161191928, 4517.887052823706, 5756.481916627524, 5756.597038207369, 5771.422857714279, 5800.245968024215, 5813.563982701315, 6290.21372328459, 6314.905276420765, 6319.747210111544, 6322.178116844781, 6326.335734747785, 5691.146328050825, 5782.132680097935, 5864.970675146682, 5868.0, 5919.881602367928, 5430.755615997289, 5446.918296225481, 5455.345358556999, 5456.7544460499375, 5457.945420545744, 6229.2524897012645, 6336.746530138835, 6367.968160159169, 6369.0764839099, 6376.202974628079, 6201.875962480635, 6234.345393733593, 6287.717052732546, 6288.27684816252, 6299.023651334051, 5400.946815370965, 6230.376962303733, 6280.27776805655, 6292.27638821523, 6345.333739957238, 6026.15633811258, 6106.096658337741, 6248.843778905563, 6249.218847644044, 6296.212973378328, 6196.10156527292, 6260.874782504416, 6273.121762953099, 6315.431611155018, 6322.683865806784, 6084.574079814371, 6130.264368275835, 6142.232220972379, 6144.354842741448, 6176.969115154396, 4891.584215341736, 6045.667488288186, 6141.048137538689, 6160.507159427325, 6389.977603583405, 5872.383399743137, 5935.258092738408, 6028.608140470856, 6075.513958883367, 6095.085737139465, 6125.264968203844, 6189.535784816067, 6217.937820621736, 6225.564210505221, 6230.906536401867, 5897.115432685132, 6015.819525414245, 6051.697415129138, 6064.818055458343, 6086.421789929949], "unit": "score", "name": "dojo.html", "value": 5678.464812377476}, {"lowerIsBetter": false, "replicates": [464.8373069425699, 500.90733214355345, 562.8489738484798, 638.1353266324131, 643.0290261704828, 36878.631213687855, 37160.62839371602, 37402.81298593503, 37450.063748406305, 37487.06282342943, 38164.427533586946, 38440.0, 38609.0, 38652.613473865254, 38654.45382184709, 9334.719958401241, 9501.80996380072, 9522.285828562852, 9524.952375238114, 9574.329796914219, 9358.953205233964, 9625.326227164067, 9634.421934683907, 9638.0, 9654.565544550513, 9576.61139134825, 9639.421634701941, 9662.855057174149, 9664.80670386592, 9686.273529485281, 8502.872456913152, 9477.857832132524, 9530.285228607847, 9597.280203984728, 9616.567254473566, 9359.110884465965, 9433.90566094344, 9474.905250947471, 9476.052394760538, 9484.19384352331, 31568.842155789305, 38080.80959595212, 38439.0, 38479.80760096209, 38615.0, 3042.4827779277352, 3074.3851229753914, 3224.7365112053753, 3766.5856755756845, 3901.0247438140464, 27201.863990680118, 27246.591301130302, 27349.0, 27434.5884811728, 27897.58153627697, 2685.0736495909077, 2725.38678797271, 2736.7821319512823, 2818.591304260871, 2823.632927719404, 321940.0, 384525.0, 390113.0, 392795.0, 394514.02742986387, 44400.77799611046, 45103.54896450994, 62717.0, 63415.36584634187, 63485.0, 43886.56113438825, 44641.0, 45052.54947450549, 45220.09559808786, 45303.0, 15259.008164469275, 15278.31247593861, 15305.6173595661, 15541.0, 15573.0, 12324.938375308066, 12467.0, 12494.81257781134, 12499.187552809039, 12537.122401431994, 12140.575079872162, 12636.30500322491, 13226.603201903958, 14075.225862577656, 14423.78364324536, 6352.809415717536, 6454.419102280817, 6459.580127291711, 6461.547691661539, 6513.2509761377105, 819.336337566573, 926.9212116970133, 963.633819148719, 1048.2714513413105, 1084.3493903657743, 21857.781422185573, 25845.870770646026, 27568.724312756614, 27748.0, 28993.275168120967, 887.1616322575104, 938.8732521109563, 1044.3264094658903, 1094.414488248783, 1181.196786185385, 14433.134011959317, 14665.56003319902, 14818.40726370933, 14865.777013344808, 14941.551753447415, 424358.0, 493726.0, 498756.0, 499550.0, 504190.0, 56856.43143568511, 57115.714421428456, 57403.71298143482, 57678.134827977614, 57726.7113664429, 1408.2254759882023, 1418.1278513713992, 1442.5600191941348, 1453.4404254362146, 1459.6277949123119, 28685.995990140244, 29074.127776166748, 29103.272418189714, 29348.0, 29477.85261073681, 50964.49035509597, 54053.0, 54831.451685482636, 55742.88514229774, 55942.720286398304, 473132.0, 475100.62449687533, 481291.0, 481874.5906270446, 483258.0, 35966.820165899, 42475.93810154771, 43508.912277193325, 43727.78136109299, 44058.0, 45374.092518150115, 45730.54269457263, 45731.31403029024, 45776.31335529903, 46087.308690370344, 35790.74732384354, 36436.81781591075, 37650.246995060494, 37864.0, 38470.0, 37074.62925370712, 37413.625863742105, 37649.247015058994, 37708.0, 38105.42841857319, 34763.0, 34925.825370874, 35990.4601430984, 36853.44719829151, 37750.0, 29996.550051748804, 31520.211994700316, 31945.0, 33213.0, 33350.83272085562, 23674.881625591763, 24031.759682402953, 24722.381940451633, 25185.0, 25223.62164567496], "unit": "score", "name": "ext.html", "value": 18858.577861599784}, {"lowerIsBetter": false, "replicates": [349.3327744008942, 359.31729713544263, 359.91541987632917, 360.9963900360996, 362.4219370104685, 14306.713865722679, 15937.362505499796, 16149.43476978306, 19171.520711982208, 20702.48243793904, 18668.719969200472, 19196.71204931927, 19243.71134432981, 19285.614287714237, 19496.025198740077, 5298.682079075248, 5538.418466061066, 5767.625104368223, 5799.971000144993, 6590.406863382294, 6463.192100987377, 6590.670466476681, 6603.0, 6614.173228346457, 6621.404073633372, 6229.626222426647, 6441.645709485976, 6455.774047908324, 6475.061116138158, 6540.313267106957, 6344.953082741342, 6373.235211774593, 6379.840503987438, 6380.872382552369, 6399.328070552595, 5484.890302193934, 5531.502164805187, 5617.38208797032, 5634.098544232903, 5649.0114230009995, 20048.39854804358, 25477.872610637012, 25806.998136355127, 25941.351466213306, 25947.740522594722, 2177.085624037908, 2408.6025805742206, 2411.867347295898, 2666.3334166458385, 2753.504369213541, 14558.98087133901, 14767.0, 14774.89188310881, 14813.259337033105, 14956.775648365174, 1272.1966661720353, 1499.025633338328, 1612.4517663994181, 1630.2093484659931, 1716.5708572856786, 108934.45532772286, 110642.44678776554, 111276.0, 112723.43638281839, 113407.0, 10404.479776011169, 10615.363078215178, 10627.893721062845, 10804.1896857736, 10862.619808306672, 10759.408232547285, 12006.759864802654, 12611.747765044647, 12893.613191604267, 12919.095663303478, 8416.284615807603, 8527.23254907049, 8572.971243450826, 8589.398742088119, 8657.783555411164, 8777.166169214042, 8860.601272942733, 8873.201411872962, 8907.777305567282, 8948.463092214488, 5099.719515426687, 6174.166487524127, 6217.564770466024, 6238.313785483593, 6274.309825919146, 1856.1021854106268, 1859.191251805469, 1860.451166905766, 1882.5952420229717, 1894.535838719495, 712.184548691745, 788.239349028179, 896.3546246702364, 932.1238036246043, 985.3693636072919, 18670.53323666892, 19123.139458724392, 20487.38537843867, 20723.27468538594, 20782.688259676117, 929.419113054341, 953.1564565359706, 969.3699095587924, 980.4999450280266, 985.9704208873745, 8433.030201526903, 9005.729828105168, 11024.173187011007, 11155.665330040112, 11171.32972021665, 577266.0, 594123.0, 604681.0, 610359.0, 617990.0, 80591.0, 102771.0, 105008.47495762473, 105561.0, 107394.0, 874.7681864305964, 1010.5604062232952, 1033.8811036730722, 1037.2479952034714, 1039.8908114647852, 18562.907185463988, 18564.907175464035, 18606.0, 18636.906815465834, 18815.529611759815, 46639.76680116577, 48913.0, 49099.018019638694, 49238.01523969429, 49329.0, 68840.31159688339, 68914.31085689079, 69124.61750764855, 69284.0, 70018.94971575329, 6439.420452159328, 7810.9218907812465, 8147.674093036212, 8153.877691834508, 8258.25675689191, 9441.905580944103, 10812.243142979916, 12541.498340066295, 13037.804432933324, 13373.866261337262, 10794.514246858753, 11263.66209013731, 11311.830322545333, 11413.942930285295, 11588.420578971187, 11284.32294062359, 11307.095432365555, 11476.254043487146, 11593.362365069665, 12075.335856527623, 11749.412529373669, 11893.345865977455, 11921.165518413974, 12036.976856967256, 12065.577704780291, 7729.574873382018, 7984.760457186294, 8047.275745182962, 8195.42632015777, 8303.833923321621, 6742.561733487308, 7960.402969777406, 8149.55091978184, 8170.406770679898, 8408.579571021546], "unit": "score", "name": "jquery.html", "value": 9391.116546067282}, {"lowerIsBetter": false, "replicates": [1547.9690406191876, 1548.5276990517896, 1795.9191836367363, 1907.7424547686066, 1918.414883460544, 7019.298070192978, 8209.850620913077, 8422.873656895152, 8471.91528084719, 8680.47917124972, 6550.0, 8457.15428457154, 8514.318854491641, 8628.91371086289, 8872.467651940888, 2407.7231118421387, 2432.3067925641194, 2441.633754936756, 2441.890114944823, 2449.730529641738, 2362.0905951208824, 2374.5844477216506, 2401.0875867170453, 2405.8195635327334, 2410.4817464245184, 2350.647402889572, 2381.9047238110456, 2392.4018995251186, 2427.2475532584867, 2429.259075981825, 2370.2178281167257, 2383.368407372039, 2387.009391102699, 2419.1532963462823, 2448.5837407640565, 2431.8905649245826, 2457.2505385857307, 2458.5943319352286, 2462.4090218347646, 2482.25532340299, 8631.784205394853, 8646.0, 8677.349198810114, 8701.60842762071, 8702.347323950666, 5109.054824857376, 5252.816151434681, 5253.185756207794, 5267.815626453055, 5287.312649355597, 3505.7721248119046, 3574.7140228781636, 3577.874774382884, 3613.765105268149, 3640.5631324240994, 1037.3237048415072, 1058.5871510111062, 1062.7502536903821, 1067.359584249452, 1067.5836423794726, 11364.943175284154, 11446.599369022044, 11460.14048946324, 11478.368689722061, 11494.655160345203, 4633.443986721615, 4663.090697314059, 4730.52694730531, 4736.19484687597, 4743.881402964885, 9817.460039697742, 9850.950745246228, 9862.45756483386, 9897.7030689078, 9898.307118501636, 5253.212018197224, 5264.236685680555, 5264.763085661154, 5270.235815806764, 5296.708681022581, 4404.625606823456, 4722.079194557028, 4786.64100192487, 4792.113459010095, 4809.206480930678, 3831.578526362098, 3892.630200130983, 3904.316744569689, 3923.0388554804254, 3943.507061617298, 1289.9161554498928, 1306.3207132291154, 1315.5132600937714, 1321.8281623388898, 1323.219300612643, 1278.9232646041266, 1295.7149427126017, 1306.9085164038615, 1342.1410297409666, 1347.9393427295795, 8094.473859199134, 8238.8352232955, 8273.296769774637, 8278.461899976483, 8297.377696672773, 1073.1790180511914, 1123.6966019174777, 1157.7105723569107, 1166.7666466706692, 1177.4289469607234, 5141.897162056738, 6082.452579267887, 6154.907676384858, 6252.155958945484, 6263.342349053284, 9987.30088893785, 10605.151587872951, 10615.0, 10665.773436054798, 10673.893261067446, 10251.846222306522, 10505.632302869362, 10518.474076296308, 10576.947115264375, 10584.259101862795, 7423.0, 8081.717139900075, 8186.2632363087605, 8294.502329860228, 8311.6675332986, 7630.542167469969, 7638.121616014229, 7722.7297044603165, 7732.845343092994, 7750.186230445722, 9264.44413335202, 9527.809443811224, 9560.043995600663, 9606.183474404754, 9656.0, 9689.563969621244, 9939.65211217604, 9954.55204515784, 10041.49792510357, 10075.294729368874, 5265.2365407015, 6725.125733654593, 6940.514164008471, 6956.234814170539, 7080.645967701491, 8096.230858068474, 8145.144759800136, 8161.877571836546, 8162.83674326522, 8171.5505647189975, 7160.713571457083, 7213.9278607213255, 7252.347288744038, 7321.670524826289, 7368.889466658112, 7009.334113259232, 7076.823079423056, 7149.034880291094, 7197.496175267681, 7267.0, 7417.0, 7555.13115991668, 7579.810504737426, 7601.201873803392, 7604.771856844303, 6906.0, 6954.721811127498, 6969.6515174242095, 6981.546199497219, 7004.194517630538, 6886.48351373659, 7039.54242974205, 7039.788806335818, 7045.154581450259, 7085.334946287721], "unit": "score", "name": "mootools.html", "value": 4866.18837626729}, {"lowerIsBetter": false, "replicates": [303.6538346285234, 321.08490801216533, 323.687641426024, 327.7967660050768, 331.54909323320294, 6783.186017677879, 6852.55458395204, 6880.208775990763, 6881.518293719441, 6909.827254318645, 6731.663416829163, 6810.284920083394, 6853.2118806337285, 6874.243833178346, 6883.483738719591, 3968.6229808168177, 4499.055198408339, 4942.851714448554, 5048.1670524363435, 5076.441591424949, 5036.798528058874, 5052.0906236877345, 5065.138926382506, 5068.5691716204165, 5124.461931497195, 4076.429299898017, 5079.847604571869, 5086.237064440326, 5088.974555127219, 5099.923501147486, 5061.696298222082, 5082.186850103984, 5091.61812864033, 5108.4125325587665, 5128.0, 4332.523422423531, 4333.133373325348, 4334.869953901388, 4350.477942646871, 4353.5428779977965, 6325.715342809584, 6571.67141642916, 6613.3056029117215, 6615.966920165417, 6661.968099729581, 4636.698614590041, 4741.19399702048, 5129.743212912823, 5490.670559766427, 5842.737076831553, 5827.592068555203, 7308.232635573241, 7317.670704818296, 7325.853482930364, 7344.632768361561, 3817.503724515823, 4641.396618439615, 4654.092451971833, 4654.115718013567, 4656.348111264392, 7646.197149299354, 7727.690892364299, 7744.883826742604, 7747.883781743279, 7753.1083925348175, 3452.4648679454726, 4453.844115455943, 4546.727196368229, 4639.768011599474, 4691.390119284471, 4066.3087275163293, 4657.115148121846, 4763.809447622126, 4777.0, 4786.856394308176, 5701.543876489954, 5711.857203569944, 5741.655500669973, 5757.769689212469, 5770.2498675171955, 5943.970280148658, 7333.816654583678, 7342.3758980487255, 7372.2259162788205, 7375.778726638209, 1564.765285207228, 1611.2266112266177, 1647.176411794103, 1655.8426949439784, 1678.479671301876, 1040.5889673578895, 1045.764702941832, 1055.714956961616, 1059.929471234059, 1061.6125114333213, 6708.228553716385, 6748.089007983859, 6754.594724316458, 6763.458923286224, 6766.086578311865, 6179.660118693515, 7552.282533159341, 7559.924400756032, 7582.317591416799, 7600.049993750781, 6719.496037797087, 6719.596824190564, 6733.93266067333, 6740.561863478858, 6754.3921047106, 3120.625524937022, 3946.506686664167, 3985.20295940813, 3991.461152744342, 4017.91964160721, 7736.845263094707, 7744.225577442324, 8068.8300196472355, 8108.918910810817, 8136.918630813734, 8021.27808497238, 8030.357571394275, 8034.276915077671, 8054.275115239657, 8057.0734365548715, 6579.440747536417, 7982.281594656509, 8061.435699500978, 8084.717034903751, 8139.959300203461, 7242.493025488376, 7611.238876112345, 7615.847683046197, 7716.305532502101, 7732.420068494773, 7448.776536703907, 7463.067116610424, 7515.286047825448, 7603.429742769204, 7631.618419079135, 8012.959935200287, 8059.098724459072, 8065.717699880476, 8071.838563228585, 8074.273315401642, 4734.55021772931, 4770.0, 4781.497942716104, 4809.807607695653, 4817.325574419654, 7457.888131678138, 7589.0, 7629.6566654499575, 7662.655180516778, 7689.730859419893, 7176.959340895436, 7334.669939852826, 7379.963100184465, 7401.555906645618, 7402.703891844266, 6220.502359811114, 7397.186309506058, 7409.555426674417, 7414.555126692416, 7458.589777562286, 7047.682854271673, 7161.319674630901, 7179.605121718356, 7192.992980982771, 7226.494145409771, 6228.4705800007505, 7216.170140433707, 7371.889421658787, 7445.627718614156, 7450.888236676563, 7205.639718014183, 7222.133343998754, 7240.782776516713, 7251.746188883364, 7278.0], "unit": "score", "name": "prototype.html", "value": 5263.392185585902}, {"lowerIsBetter": false, "replicates": [695.3950063444804, 717.7523754304763, 729.9197088320285, 739.711512510121, 741.6328917185987, 14618.48835290765, 14708.411663533472, 14770.778438323421, 14786.852131478681, 14810.851891481081, 12813.807792883114, 12830.486780528767, 12843.35783210838, 12850.421731022103, 12867.54963576275, 693.4383149648776, 842.465034702965, 842.7808769719855, 864.0409145848104, 871.3029576338935, 852.765489490392, 854.679495189304, 863.7149740585592, 864.6541383446609, 865.9740207793776, 915.514777168102, 917.6054296652437, 922.0502882031518, 923.5890028937125, 923.8429466990627, 898.7842917699737, 905.316486053029, 911.3939230411768, 913.7943962608426, 916.5234078279291, 654.7119267522274, 655.4068567946016, 669.581511555278, 676.5298117808076, 680.4930326906436, 14269.357878895475, 14346.354414051393, 14371.71256574873, 14429.567112986628, 14450.205238711867, 12391.62825115248, 12517.311547864863, 12584.119111662187, 12726.554570590077, 12784.360781960864, 9925.851112233322, 10012.799744005151, 10069.395836249776, 10093.747656308578, 10371.377717336984, 3441.174118211611, 3468.9826550867338, 3473.565804274466, 3515.894523164284, 3589.3180295743723, 78975.42049159043, 79670.20329796686, 79773.0, 80121.59939200267, 80628.19371806324, 9004.4337363851, 9032.096790320915, 9059.320550958704, 9088.727338179866, 9129.876758556824, 20327.0, 20555.691664625043, 20575.691364629543, 20603.58792824135, 20642.17431302731, 7371.741989030358, 7465.141508726566, 7466.552006879605, 7558.697652093964, 7644.541327520366, 3453.7582369233915, 3953.6244056814558, 3975.4235635832642, 3984.900377490586, 3992.500937382827, 3306.272620023591, 3466.5666791651042, 3468.497067925137, 3493.5633045869267, 3520.2959408117968, 613.3253421236604, 667.7095463473307, 676.0602762160601, 680.2143524229523, 700.6286668065933, 481.4905271972392, 565.4147956864707, 583.7635757518212, 584.9356570777211, 608.0484042473515, 6089.512838972872, 8128.349732021424, 8374.330053595697, 8480.915190848136, 8677.349198810114, 462.50280947981054, 550.8292429346915, 593.2506558549923, 597.9043353063576, 601.3265143039736, 3598.514200582888, 3757.774533527997, 3789.5452545694143, 3909.4526766252748, 4027.7180597357906, 79066.0, 81868.18131818605, 81943.0, 82347.58826205951, 82581.58709206416, 69699.3030069703, 70374.64812675904, 71101.93347099797, 71343.64328178325, 71888.28111718816, 62675.35921767063, 63091.0, 63117.36882631115, 63545.0, 63936.68031659812, 7669.3864490841715, 7674.8081297968, 7675.53946763196, 7699.883516889908, 7711.38308935295, 31323.0, 45162.32256516089, 45685.85785355393, 46115.769421152676, 46121.769391152826, 59104.52238694067, 59317.70341148267, 59605.40394595999, 60764.39235607764, 61088.38911610827, 9527.142557169887, 9531.094546018117, 9618.759531011781, 9874.901250987397, 9954.701358959242, 10415.270931034755, 10462.895371046496, 10504.0, 10665.9466702666, 10967.341959482457, 10050.09549140581, 10081.899181008095, 10103.898961010296, 10314.226433017704, 10938.289011214245, 9193.310501712533, 10192.082712555906, 10230.437325947145, 10477.895221047997, 10537.894621053998, 10056.748581285234, 10084.445355505517, 10292.433916134385, 10339.017793309924, 10368.844467333147, 8534.573271336532, 8544.0, 8820.9498798406, 8887.688930887389, 8905.441547729251, 9075.092490751136, 9366.95316523413, 9447.52762361893, 9520.857187142337, 9553.61785528571], "unit": "score", "name": "yui.html", "value": 6530.77286684682}], "name": "dromaeo_css", "value": 7429.933700908638}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 107.0, 109.0, 113.0, 114.0, 126.0, 114.0, 117.0, 116.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [157.0, 125.0, 148.0, 157.0, 122.0, 143.0, 138.0, 126.0, 159.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 139.7}, {"lowerIsBetter": true, "replicates": [199.0, 200.0, 197.0, 210.0, 231.0, 278.0, 241.0, 203.0, 199.0, 198.0], "unit": "score", "name": "audio-dft", "value": 215.6}, {"lowerIsBetter": true, "replicates": [67.0, 78.0, 76.0, 141.0, 88.0, 83.0, 87.0, 88.0, 121.0, 58.0], "unit": "score", "name": "audio-fft", "value": 88.7}, {"lowerIsBetter": true, "replicates": [86.0, 82.0, 124.0, 81.0, 118.0, 116.0, 126.0, 81.0, 82.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 101.0}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 89.0, 87.0, 109.0, 86.0, 89.0, 87.0, 88.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 101.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 95.7}, {"lowerIsBetter": true, "replicates": [92.0, 95.0, 91.0, 92.0, 93.0, 91.0, 89.0, 91.0, 92.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 91.7}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 56.0, 58.0, 57.0, 54.0, 63.0, 62.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 71.0, 69.0, 68.0, 76.0, 97.0, 105.0, 99.0, 99.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 81.5}, {"lowerIsBetter": true, "replicates": [84.0, 90.0, 103.0, 112.0, 114.0, 97.0, 91.0, 87.0, 91.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 95.9}, {"lowerIsBetter": true, "replicates": [138.0, 122.0, 134.0, 122.0, 114.0, 137.0, 119.0, 140.0, 135.0, 139.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.0}, {"lowerIsBetter": true, "replicates": [150.0, 176.0, 125.0, 167.0, 190.0, 185.0, 147.0, 146.0, 156.0, 187.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 162.9}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 70.0, 70.0, 77.0, 100.0, 94.0, 58.0, 76.0, 93.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.4}], "name": "kraken", "value": 1541.7000000000003}]} 21:07:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1541.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7429.93"}}} 21:07:09 INFO - Return code: 0 21:07:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:07:09 ERROR - # TBPL SUCCESS # 21:07:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:07:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:07:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:07:09 INFO - 2016-03-02 21:07:09.437 screenresolution[1684:11069] starting screenresolution argv=screenresolution get 21:07:09 INFO - 2016-03-02 21:07:09.439 screenresolution[1684:11069] Display 0: 1600x1200x32@60 21:07:09 INFO - 2016-03-02 21:07:09.445 screenresolution[1685:11072] starting screenresolution argv=screenresolution list 21:07:09 INFO - Available Modes on Display 0 21:07:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:07:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:07:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:07:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:07:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:07:09 INFO - Intel Iris: 21:07:09 INFO - Chipset Model: Intel Iris 21:07:09 INFO - Type: GPU 21:07:09 INFO - Bus: Built-In 21:07:09 INFO - VRAM (Dynamic, Max): 1536 MB 21:07:09 INFO - Vendor: Intel (0x8086) 21:07:09 INFO - Device ID: 0x0a2e 21:07:09 INFO - Revision ID: 0x0009 21:07:09 INFO - Displays: 21:07:09 INFO - Display: 21:07:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:07:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:07:09 INFO - Display Serial Number: 1600x1200 60 21:07:09 INFO - Main Display: Yes 21:07:09 INFO - Mirror: Off 21:07:09 INFO - Online: Yes 21:07:09 INFO - Rotation: Supported 21:07:09 INFO - Return code: 0 21:07:09 INFO - Running post-action listener: _resource_record_post_action 21:07:09 INFO - Running post-run listener: _resource_record_post_run 21:07:10 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 39419392; Write bytes: 710465024; Read time: 551; Write time: 2301 21:07:10 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 396839424; Write bytes: 390555648; Read time: 30104; Write time: 677 21:07:10 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 37522944; Write bytes: 306220544; Read time: 531; Write time: 1587 21:07:10 INFO - Running post-run listener: _upload_blobber_files 21:07:10 INFO - Blob upload gear active. 21:07:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:07:10 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 21:07:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:07:11 INFO - (blobuploader) - INFO - Open directory for files ... 21:07:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:07:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:07:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:07:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:07:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:07:12 INFO - (blobuploader) - INFO - Done attempting. 21:07:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:07:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:07:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:07:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:07:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:07:13 INFO - (blobuploader) - INFO - Done attempting. 21:07:13 INFO - (blobuploader) - INFO - Iteration through files over. 21:07:13 INFO - Return code: 0 21:07:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:07:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:07:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b0cfc953785d896974531bba197b827d08fc82a8c94ace3eb2f9fd1e452b379bb0843066c655c1dbb9268c3619ff243e4adc71c6b26d3426ef01881454e27aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8268ac60fafecf2b3ae35b1f3e90f9d1c94752de881075ceaba892db03313a9460087faf9908e8887861371de410e976437b7c4bde02e4e56515e59d93ba69c"} 21:07:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:07:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:07:13 INFO - Contents: 21:07:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b0cfc953785d896974531bba197b827d08fc82a8c94ace3eb2f9fd1e452b379bb0843066c655c1dbb9268c3619ff243e4adc71c6b26d3426ef01881454e27aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8268ac60fafecf2b3ae35b1f3e90f9d1c94752de881075ceaba892db03313a9460087faf9908e8887861371de410e976437b7c4bde02e4e56515e59d93ba69c"} 21:07:13 INFO - Running post-run listener: copy_logs_to_upload_dir 21:07:13 INFO - Copying logs to upload dir... 21:07:13 INFO - mkdir: /builds/slave/test/build/upload/logs 21:07:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.614669 ========= master_lag: 87.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 33 secs) (at 2016-03-02 21:08:40.139028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 22 secs) (at 2016-03-02 21:08:40.143815) ========= 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.oVD7WUcXKt/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.m0E0eugPUG/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b0cfc953785d896974531bba197b827d08fc82a8c94ace3eb2f9fd1e452b379bb0843066c655c1dbb9268c3619ff243e4adc71c6b26d3426ef01881454e27aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8268ac60fafecf2b3ae35b1f3e90f9d1c94752de881075ceaba892db03313a9460087faf9908e8887861371de410e976437b7c4bde02e4e56515e59d93ba69c"} build_url:https://queue.taskcluster.net/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011583 build_url: 'https://queue.taskcluster.net/v1/task/eXwfxtZRQtuzbrp6QBPM0Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b0cfc953785d896974531bba197b827d08fc82a8c94ace3eb2f9fd1e452b379bb0843066c655c1dbb9268c3619ff243e4adc71c6b26d3426ef01881454e27aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8268ac60fafecf2b3ae35b1f3e90f9d1c94752de881075ceaba892db03313a9460087faf9908e8887861371de410e976437b7c4bde02e4e56515e59d93ba69c"}' ========= master_lag: 22.24 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 22 secs) (at 2016-03-02 21:09:02.392044) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 21:09:02.392381) ========= 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.oVD7WUcXKt/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.m0E0eugPUG/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005489 ========= master_lag: 1.99 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 21:09:04.391898) ========= ========= Started reboot skipped (results: 3, elapsed: 6 secs) (at 2016-03-02 21:09:04.392183) ========= ========= Finished reboot skipped (results: 3, elapsed: 6 secs) (at 2016-03-02 21:09:11.346917) ========= ========= Total master_lag: 145.28 =========