builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0067 starttime: 1454761903.97 results: success (0) buildid: 20160206043142 builduid: 2715030249a94cfd8171a4de8615ec89 revision: f5bd25c789b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:43.967041) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:43.967502) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:43.967824) ========= 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.yUNaPTEP6B/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.Es7X9hk15m/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.005630 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:43.996919) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:43.997299) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:44.014676) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:44.015113) ========= 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.yUNaPTEP6B/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.Es7X9hk15m/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.005631 ========= master_lag: 0.22 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:44.243135) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:44.243458) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:44.243853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:44.244172) ========= 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.yUNaPTEP6B/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.Es7X9hk15m/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-02-06 04:31:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.35M=0.001s 2016-02-06 04:31:44 (9.35 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.561340 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:44.821145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:44.821527) ========= 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.yUNaPTEP6B/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.Es7X9hk15m/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.026956 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:44.870481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 04:31:44.870880) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f5bd25c789b6 --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 f5bd25c789b6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yUNaPTEP6B/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.Es7X9hk15m/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-02-06 04:31:44,937 Setting DEBUG logging. 2016-02-06 04:31:44,937 attempt 1/10 2016-02-06 04:31:44,937 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f5bd25c789b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 04:31:45,850 unpacking tar archive at: fx-team-f5bd25c789b6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.158776 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 04:31:46.048453) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:46.048876) ========= echo f5bd25c789b6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f5bd25c789b6'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yUNaPTEP6B/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.Es7X9hk15m/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 f5bd25c789b6 program finished with exit code 0 elapsedTime=0.005600 script_repo_revision: 'f5bd25c789b6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:46.104536) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:46.104931) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:46.124383) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-02-06 04:31:46.129076) ========= /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.yUNaPTEP6B/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.Es7X9hk15m/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 04:31:46 INFO - MultiFileLogger online at 20160206 04:31:46 in /builds/slave/test 04:31:46 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 04:31:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:46 INFO - {'append_to_log': False, 04:31:46 INFO - 'base_work_dir': '/builds/slave/test', 04:31:46 INFO - 'blob_upload_branch': 'Fx-Team', 04:31:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:46 INFO - 'branch': 'Fx-Team', 04:31:46 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:46 INFO - 'config_files': ('talos/mac_config.py',), 04:31:46 INFO - 'default_actions': ('clobber', 04:31:46 INFO - 'read-buildbot-config', 04:31:46 INFO - 'download-and-extract', 04:31:46 INFO - 'populate-webroot', 04:31:46 INFO - 'create-virtualenv', 04:31:46 INFO - 'install', 04:31:46 INFO - 'run-tests'), 04:31:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:46 INFO - 'download_minidump_stackwalk': True, 04:31:46 INFO - 'download_symbols': 'ondemand', 04:31:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:46 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:46 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:46 INFO - 'installer_path': 'installer.exe', 04:31:46 INFO - 'log_level': 'info', 04:31:46 INFO - 'log_name': 'talos', 04:31:46 INFO - 'log_to_console': True, 04:31:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:31:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:31:46 INFO - 'opt_config_files': (), 04:31:46 INFO - 'pip_index': False, 04:31:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:46 INFO - 'cmd': ('bash', 04:31:46 INFO - '-c', 04:31:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:46 INFO - 'enabled': True, 04:31:46 INFO - 'halt_on_failure': False, 04:31:46 INFO - 'name': 'check_screen_resolution'},), 04:31:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:46 INFO - 'cmd': ('bash', 04:31:46 INFO - '-c', 04:31:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:46 INFO - 'enabled': True, 04:31:46 INFO - 'halt_on_failure': False, 04:31:46 INFO - 'name': 'check_screen_resolution'},), 04:31:46 INFO - 'run_cmd_checks_enabled': True, 04:31:46 INFO - 'sps_profile': False, 04:31:46 INFO - 'sps_profile_interval': 0, 04:31:46 INFO - 'suite': 'dromaeojs-e10s', 04:31:46 INFO - 'system_bits': '32', 04:31:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:46 INFO - 'title': 't-yosemite-r7-0067', 04:31:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:46 INFO - 'use_talos_json': True, 04:31:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:46 INFO - 'work_dir': 'build'} 04:31:46 INFO - ##### 04:31:46 INFO - ##### Running clobber step. 04:31:46 INFO - ##### 04:31:46 INFO - Running pre-action listener: _resource_record_pre_action 04:31:46 INFO - Running main action method: clobber 04:31:46 INFO - rmtree: /builds/slave/test/build 04:31:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:47 INFO - Running post-action listener: _resource_record_post_action 04:31:47 INFO - ##### 04:31:47 INFO - ##### Running read-buildbot-config step. 04:31:47 INFO - ##### 04:31:47 INFO - Running pre-action listener: _resource_record_pre_action 04:31:47 INFO - Running main action method: read_buildbot_config 04:31:47 INFO - Using buildbot properties: 04:31:47 INFO - { 04:31:47 INFO - "project": "", 04:31:47 INFO - "product": "firefox", 04:31:47 INFO - "script_repo_revision": "production", 04:31:47 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 04:31:47 INFO - "repository": "", 04:31:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 04:31:47 INFO - "buildid": "20160206043142", 04:31:47 INFO - "stage_platform": "macosx64", 04:31:47 INFO - "basedir": "/builds/slave/test", 04:31:47 INFO - "buildnumber": 390, 04:31:47 INFO - "platform": "yosemite_r7", 04:31:47 INFO - "mozci_request": { 04:31:47 INFO - "priority": -1, 04:31:47 INFO - "type": "trigger_all_talos_jobs", 04:31:47 INFO - "times": 6 04:31:47 INFO - }, 04:31:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:31:47 INFO - "slavebuilddir": "test", 04:31:47 INFO - "branch": "fx-team", 04:31:47 INFO - "revision": "f5bd25c789b6", 04:31:47 INFO - "slavename": "t-yosemite-r7-0067", 04:31:47 INFO - "builduid": "2715030249a94cfd8171a4de8615ec89", 04:31:47 INFO - "repo_path": "integration/fx-team" 04:31:47 INFO - } 04:31:47 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg. 04:31:47 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json. 04:31:47 INFO - Running post-action listener: _resource_record_post_action 04:31:47 INFO - ##### 04:31:47 INFO - ##### Running download-and-extract step. 04:31:47 INFO - ##### 04:31:47 INFO - Running pre-action listener: _resource_record_pre_action 04:31:47 INFO - Running main action method: download_and_extract 04:31:47 INFO - mkdir: /builds/slave/test/build/tests 04:31:47 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')]} 04:31:47 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json 04:31:47 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json to /builds/slave/test/build/test_packages.json 04:31:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:31:48 INFO - Downloaded 1277 bytes. 04:31:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:31:48 INFO - Using the following test package requirements: 04:31:48 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:48 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:48 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:31:48 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:48 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:31:48 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:48 INFO - u'jsshell-mac.zip'], 04:31:48 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:48 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:31:48 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:48 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:48 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:31:48 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:48 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:31:48 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:48 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:31:48 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:48 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:48 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:31:48 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:48 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:48 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/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 04:31:48 INFO - Downloaded 17118738 bytes. 04:31:48 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'] 04:31:48 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 04:31:51 INFO - Return code: 0 04:31:51 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 04:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:51 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:51 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/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 04:31:51 INFO - Downloaded 17118738 bytes. 04:31:51 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'] 04:31:51 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 04:31:55 INFO - Return code: 0 04:31: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')]} 04:31:55 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.talos.tests.zip 04:31:55 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/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 04:31:55 INFO - Downloaded 10706582 bytes. 04:31:55 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'] 04:31:55 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 04:31:55 INFO - Return code: 0 04:31: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')]} 04:31:55 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:31:55 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:31:57 INFO - Downloaded 111115296 bytes. 04:31:57 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:31:57 INFO - mkdir: /builds/slave/test/properties 04:31:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:57 INFO - Contents: 04:31:57 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:31:57 INFO - Running post-action listener: _resource_record_post_action 04:31:57 INFO - Running post-action listener: set_extra_try_arguments 04:31:57 INFO - ##### 04:31:57 INFO - ##### Running populate-webroot step. 04:31:57 INFO - ##### 04:31:57 INFO - Running pre-action listener: _resource_record_pre_action 04:31:57 INFO - Running main action method: populate_webroot 04:31:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:57 INFO - '--tppagecycles', 04:31:57 INFO - '7'], 04:31:57 INFO - 'tests': ['tsvgm']}}, 04:31:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:31:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:31:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'tests': ['damp', 'tps']}, 04:31:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['damp', 'tps']}, 04:31:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:31:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:57 INFO - 'other': {'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other_l64': {'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other_nol64': {'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'svgr': {'tests': ['tsvgx', 04:31:57 INFO - 'tsvgr_opacity', 04:31:57 INFO - 'tart', 04:31:57 INFO - 'tscrollx', 04:31:57 INFO - 'cart']}, 04:31:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['tsvgx', 04:31:57 INFO - 'tsvgr_opacity', 04:31:57 INFO - 'tart', 04:31:57 INFO - 'tscrollx', 04:31:57 INFO - 'cart']}, 04:31:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'tests': ['tp5o']}, 04:31:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['tp5o']}, 04:31:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--xperf_path', 04:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:57 INFO - 'tests': ['tp5n']}, 04:31:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--e10s', 04:31:57 INFO - '--xperf_path', 04:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:57 INFO - 'tests': ['tp5n']}}, 04:31:57 INFO - 'talos.zip': {'path': '', 04:31:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:57 INFO - Running post-action listener: _resource_record_post_action 04:31:57 INFO - ##### 04:31:57 INFO - ##### Running create-virtualenv step. 04:31:57 INFO - ##### 04:31:57 INFO - Running pre-action listener: _resource_record_pre_action 04:31:57 INFO - Running main action method: create_virtualenv 04:31:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:57 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 04:31:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:57 INFO - Using real prefix '/tools/python27' 04:31:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:01 INFO - Installing pip.................done. 04:32:01 INFO - Return code: 0 04:32:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1061fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9c6d160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060a3d30>, '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 0x105f06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106099b20>, '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.yUNaPTEP6B/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.Es7X9hk15m/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 04:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:32:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUNaPTEP6B/Render', 04:32:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:01 INFO - 'HOME': '/Users/cltbld', 04:32:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:01 INFO - 'LOGNAME': 'cltbld', 04:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:01 INFO - 'MOZ_NO_REMOTE': '1', 04:32:01 INFO - 'NO_EM_RESTART': '1', 04:32:01 INFO - 'PAGER': '/bin/cat', 04:32:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:01 INFO - 'PWD': '/builds/slave/test', 04:32:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:01 INFO - 'SHELL': '/bin/bash', 04:32:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Es7X9hk15m/Listeners', 04:32:01 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 04:32:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:01 INFO - 'USER': 'cltbld', 04:32:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:01 INFO - 'XPC_FLAGS': '0x0', 04:32:01 INFO - 'XPC_SERVICE_NAME': '0', 04:32:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:01 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 04:32:01 INFO - Cleaning up... 04:32:01 INFO - Return code: 0 04:32:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1061fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9c6d160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060a3d30>, '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 0x105f06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106099b20>, '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.yUNaPTEP6B/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.Es7X9hk15m/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 04:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:32:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUNaPTEP6B/Render', 04:32:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:01 INFO - 'HOME': '/Users/cltbld', 04:32:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:01 INFO - 'LOGNAME': 'cltbld', 04:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:01 INFO - 'MOZ_NO_REMOTE': '1', 04:32:01 INFO - 'NO_EM_RESTART': '1', 04:32:01 INFO - 'PAGER': '/bin/cat', 04:32:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:01 INFO - 'PWD': '/builds/slave/test', 04:32:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:01 INFO - 'SHELL': '/bin/bash', 04:32:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Es7X9hk15m/Listeners', 04:32:01 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 04:32:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:01 INFO - 'USER': 'cltbld', 04:32:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:01 INFO - 'XPC_FLAGS': '0x0', 04:32:01 INFO - 'XPC_SERVICE_NAME': '0', 04:32:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:01 INFO - Downloading/unpacking psutil>=0.7.1 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:05 INFO - Installing collected packages: psutil 04:32:05 INFO - Running setup.py install for psutil 04:32:05 INFO - building 'psutil._psutil_osx' extension 04:32:05 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 04:32:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:32:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:32:06 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 04:32:06 INFO - building 'psutil._psutil_posix' extension 04:32:06 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 04:32:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:32:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:32:06 INFO - ^ 04:32:06 INFO - 1 warning generated. 04:32:06 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 04:32:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:06 INFO - Successfully installed psutil 04:32:06 INFO - Cleaning up... 04:32:06 INFO - Return code: 0 04:32:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:06 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 0x1061fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9c6d160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060a3d30>, '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 0x105f06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106099b20>, '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.yUNaPTEP6B/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.Es7X9hk15m/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 04:32:06 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 04:32:06 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 04:32:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUNaPTEP6B/Render', 04:32:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:06 INFO - 'HOME': '/Users/cltbld', 04:32:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:06 INFO - 'LOGNAME': 'cltbld', 04:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:06 INFO - 'MOZ_NO_REMOTE': '1', 04:32:06 INFO - 'NO_EM_RESTART': '1', 04:32:06 INFO - 'PAGER': '/bin/cat', 04:32:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:06 INFO - 'PWD': '/builds/slave/test', 04:32:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:06 INFO - 'SHELL': '/bin/bash', 04:32:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Es7X9hk15m/Listeners', 04:32:06 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 04:32:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:06 INFO - 'USER': 'cltbld', 04:32:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:06 INFO - 'XPC_FLAGS': '0x0', 04:32:06 INFO - 'XPC_SERVICE_NAME': '0', 04:32:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:32:06 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 04:32:06 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 04:32:06 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 04:32:06 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 04:32:06 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 04:32:06 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 04:32:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:32:09 INFO - Installing collected packages: mozsystemmonitor 04:32:09 INFO - Running setup.py install for mozsystemmonitor 04:32:09 INFO - Successfully installed mozsystemmonitor 04:32:09 INFO - Cleaning up... 04:32:09 INFO - Return code: 0 04:32:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:09 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 0x1061fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9c6d160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060a3d30>, '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 0x105f06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106099b20>, '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.yUNaPTEP6B/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.Es7X9hk15m/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 04:32:09 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 04:32:09 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 04:32:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUNaPTEP6B/Render', 04:32:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:09 INFO - 'HOME': '/Users/cltbld', 04:32:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:09 INFO - 'LOGNAME': 'cltbld', 04:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:09 INFO - 'MOZ_NO_REMOTE': '1', 04:32:09 INFO - 'NO_EM_RESTART': '1', 04:32:09 INFO - 'PAGER': '/bin/cat', 04:32:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:09 INFO - 'PWD': '/builds/slave/test', 04:32:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:09 INFO - 'SHELL': '/bin/bash', 04:32:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Es7X9hk15m/Listeners', 04:32:09 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 04:32:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:09 INFO - 'USER': 'cltbld', 04:32:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:09 INFO - 'XPC_FLAGS': '0x0', 04:32:09 INFO - 'XPC_SERVICE_NAME': '0', 04:32:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:09 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:11 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:12 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 04:32:12 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 04:32:12 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 04:32:12 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 04:32:12 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 04:32:12 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 04:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:12 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 04:32:12 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 04:32:12 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 04:32:12 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 04:32:12 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 04:32:12 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 04:32:13 INFO - Downloading docopt-0.6.1.tar.gz 04:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:13 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:13 INFO - Running setup.py install for blobuploader 04:32:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:13 INFO - Running setup.py install for requests 04:32:13 INFO - Running setup.py install for docopt 04:32:14 INFO - Successfully installed blobuploader requests docopt 04:32:14 INFO - Cleaning up... 04:32:14 INFO - Return code: 0 04:32:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:14 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 0x1061fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9c6d160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060a3d30>, '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 0x105f06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106099b20>, '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.yUNaPTEP6B/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.Es7X9hk15m/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 04:32:14 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 04:32:14 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 04:32:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUNaPTEP6B/Render', 04:32:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:14 INFO - 'HOME': '/Users/cltbld', 04:32:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:14 INFO - 'LOGNAME': 'cltbld', 04:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:14 INFO - 'MOZ_NO_REMOTE': '1', 04:32:14 INFO - 'NO_EM_RESTART': '1', 04:32:14 INFO - 'PAGER': '/bin/cat', 04:32:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:14 INFO - 'PWD': '/builds/slave/test', 04:32:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:14 INFO - 'SHELL': '/bin/bash', 04:32:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Es7X9hk15m/Listeners', 04:32:14 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 04:32:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:14 INFO - 'USER': 'cltbld', 04:32:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:14 INFO - 'XPC_FLAGS': '0x0', 04:32:14 INFO - 'XPC_SERVICE_NAME': '0', 04:32:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-718ZLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-T939Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-yzmW8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-zI5Oyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-O6lYJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-37yOPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:14 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-MtEs7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:15 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-xGz6wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:15 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-LrLuo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:15 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-7ORWJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:15 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-cpfVhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:15 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-HpAZVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:15 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-LCm_u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:15 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-LYxZpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:15 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-nJlzpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:15 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-VZ6ALT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:16 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-stTda1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:16 INFO - Running setup.py install for manifestparser 04:32:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Running setup.py install for mozcrash 04:32:16 INFO - Running setup.py install for mozdebug 04:32:16 INFO - Running setup.py install for mozdevice 04:32:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Running setup.py install for mozfile 04:32:16 INFO - Running setup.py install for mozhttpd 04:32:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Running setup.py install for mozinfo 04:32:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Running setup.py install for mozInstall 04:32:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Running setup.py install for mozleak 04:32:17 INFO - Running setup.py install for mozlog 04:32:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Running setup.py install for moznetwork 04:32:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Running setup.py install for mozprocess 04:32:17 INFO - Running setup.py install for mozprofile 04:32:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:18 INFO - Running setup.py install for mozrunner 04:32:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:18 INFO - Running setup.py install for mozscreenshot 04:32:18 INFO - Running setup.py install for moztest 04:32:18 INFO - Running setup.py install for mozversion 04:32:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:18 INFO - Cleaning up... 04:32:18 INFO - Return code: 0 04:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:18 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')]} 04:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:18 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')]} 04:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:18 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 0x1061fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9c6d160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060a3d30>, '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 0x105f06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106099b20>, '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.yUNaPTEP6B/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.Es7X9hk15m/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 04:32:18 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 04:32:18 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 04:32:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUNaPTEP6B/Render', 04:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:18 INFO - 'HOME': '/Users/cltbld', 04:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:18 INFO - 'LOGNAME': 'cltbld', 04:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:18 INFO - 'MOZ_NO_REMOTE': '1', 04:32:18 INFO - 'NO_EM_RESTART': '1', 04:32:18 INFO - 'PAGER': '/bin/cat', 04:32:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:18 INFO - 'PWD': '/builds/slave/test', 04:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:18 INFO - 'SHELL': '/bin/bash', 04:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Es7X9hk15m/Listeners', 04:32:18 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 04:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:18 INFO - 'USER': 'cltbld', 04:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:18 INFO - 'XPC_FLAGS': '0x0', 04:32:18 INFO - 'XPC_SERVICE_NAME': '0', 04:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:18 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-FLbOxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-xrF94g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-4RZuiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-ykjMh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-rTEg3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-FQurYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-krzrIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-x7iuHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-8b9NVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-7qjzc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:19 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-9iCONB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:20 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)) 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:20 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-FyI6f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:20 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)) 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:20 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-6YmhjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:20 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)) 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:20 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-nBxPOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:20 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)) 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:20 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-MvEUjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:20 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)) 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:20 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-NpSH4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:20 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)) 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:20 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-FNvks3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:20 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)) 04:32:20 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)) 04:32:20 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)) 04:32:20 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)) 04:32:20 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)) 04:32:20 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)) 04:32:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:23 INFO - Downloading blessings-1.6.tar.gz 04:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:24 INFO - Installing collected packages: blessings 04:32:24 INFO - Running setup.py install for blessings 04:32:24 INFO - Successfully installed blessings 04:32:24 INFO - Cleaning up... 04:32:24 INFO - Return code: 0 04:32:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:24 INFO - Reading from file tmpfile_stdout 04:32:24 INFO - Current package versions: 04:32:24 INFO - blessings == 1.6 04:32:24 INFO - blobuploader == 1.2.4 04:32:24 INFO - docopt == 0.6.1 04:32:24 INFO - manifestparser == 1.1 04:32:24 INFO - mozInstall == 1.12 04:32:24 INFO - mozcrash == 0.16 04:32:24 INFO - mozdebug == 0.1 04:32:24 INFO - mozdevice == 0.48 04:32:24 INFO - mozfile == 1.2 04:32:24 INFO - mozhttpd == 0.7 04:32:24 INFO - mozinfo == 0.9 04:32:24 INFO - mozleak == 0.1 04:32:24 INFO - mozlog == 3.1 04:32:24 INFO - moznetwork == 0.27 04:32:24 INFO - mozprocess == 0.22 04:32:24 INFO - mozprofile == 0.28 04:32:24 INFO - mozrunner == 6.11 04:32:24 INFO - mozscreenshot == 0.1 04:32:24 INFO - mozsystemmonitor == 0.0 04:32:24 INFO - moztest == 0.7 04:32:24 INFO - mozversion == 1.4 04:32:24 INFO - psutil == 3.1.1 04:32:24 INFO - requests == 1.2.3 04:32:24 INFO - wsgiref == 0.1.2 04:32:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:24 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 0x1061fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9c6d160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060a3d30>, '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 0x105f06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106099b20>, '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.yUNaPTEP6B/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.Es7X9hk15m/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 04:32:24 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 04:32:24 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 04:32:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUNaPTEP6B/Render', 04:32:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:24 INFO - 'HOME': '/Users/cltbld', 04:32:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:24 INFO - 'LOGNAME': 'cltbld', 04:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:24 INFO - 'MOZ_NO_REMOTE': '1', 04:32:24 INFO - 'NO_EM_RESTART': '1', 04:32:24 INFO - 'PAGER': '/bin/cat', 04:32:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:24 INFO - 'PWD': '/builds/slave/test', 04:32:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:24 INFO - 'SHELL': '/bin/bash', 04:32:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Es7X9hk15m/Listeners', 04:32:24 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 04:32:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:24 INFO - 'USER': 'cltbld', 04:32:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:24 INFO - 'XPC_FLAGS': '0x0', 04:32:24 INFO - 'XPC_SERVICE_NAME': '0', 04:32:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:24 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)) 04:32:24 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)) 04:32:24 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)) 04:32:24 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)) 04:32:24 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)) 04:32:24 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)) 04:32:24 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)) 04:32:24 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)) 04:32:24 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)) 04:32:24 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)) 04:32:24 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)) 04:32:24 INFO - Cleaning up... 04:32:24 INFO - Return code: 0 04:32:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:24 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 0x1061fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9c6d160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060a3d30>, '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 0x105f06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106099b20>, '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.yUNaPTEP6B/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.Es7X9hk15m/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 04:32:24 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 04:32:24 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 04:32:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUNaPTEP6B/Render', 04:32:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:24 INFO - 'HOME': '/Users/cltbld', 04:32:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:24 INFO - 'LOGNAME': 'cltbld', 04:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:24 INFO - 'MOZ_NO_REMOTE': '1', 04:32:24 INFO - 'NO_EM_RESTART': '1', 04:32:24 INFO - 'PAGER': '/bin/cat', 04:32:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:24 INFO - 'PWD': '/builds/slave/test', 04:32:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:24 INFO - 'SHELL': '/bin/bash', 04:32:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Es7X9hk15m/Listeners', 04:32:24 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 04:32:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:24 INFO - 'USER': 'cltbld', 04:32:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:24 INFO - 'XPC_FLAGS': '0x0', 04:32:24 INFO - 'XPC_SERVICE_NAME': '0', 04:32:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:25 INFO - Downloading/unpacking jsonschema 04:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:27 INFO - Downloading/unpacking functools32 (from jsonschema) 04:32:27 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 04:32:27 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 04:32:27 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 04:32:27 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 04:32:27 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 04:32:27 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 04:32:27 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:27 INFO - warning: no files found matching '*.txt' 04:32:27 INFO - no previously-included directories found matching 'build' 04:32:27 INFO - no previously-included directories found matching 'dist' 04:32:27 INFO - no previously-included directories found matching '.git*' 04:32:27 INFO - Installing collected packages: jsonschema, functools32 04:32:27 INFO - Running setup.py install for functools32 04:32:28 INFO - warning: no files found matching '*.txt' 04:32:28 INFO - no previously-included directories found matching 'build' 04:32:28 INFO - no previously-included directories found matching 'dist' 04:32:28 INFO - no previously-included directories found matching '.git*' 04:32:28 INFO - Successfully installed jsonschema functools32 04:32:28 INFO - Cleaning up... 04:32:28 INFO - Return code: 0 04:32:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:32:28 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')]} 04:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:28 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')]} 04:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:28 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 0x1061fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e9c6d160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060a3d30>, '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 0x105f06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106099b20>, '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.yUNaPTEP6B/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.Es7X9hk15m/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 04:32:28 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 04:32:28 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 04:32:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUNaPTEP6B/Render', 04:32:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:28 INFO - 'HOME': '/Users/cltbld', 04:32:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:28 INFO - 'LOGNAME': 'cltbld', 04:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:28 INFO - 'MOZ_NO_REMOTE': '1', 04:32:28 INFO - 'NO_EM_RESTART': '1', 04:32:28 INFO - 'PAGER': '/bin/cat', 04:32:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:28 INFO - 'PWD': '/builds/slave/test', 04:32:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:28 INFO - 'SHELL': '/bin/bash', 04:32:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Es7X9hk15m/Listeners', 04:32:28 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 04:32:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:28 INFO - 'USER': 'cltbld', 04:32:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:28 INFO - 'XPC_FLAGS': '0x0', 04:32:28 INFO - 'XPC_SERVICE_NAME': '0', 04:32:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:28 INFO - Downloading/unpacking flake8 04:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:32:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:32:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:31 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 04:32:31 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 04:32:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:32:31 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 04:32:31 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 04:32:31 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 04:32:31 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 04:32:31 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 04:32:31 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 04:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:32:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:31 INFO - no previously-included directories found matching 'docs/_build' 04:32:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:32:31 INFO - Running setup.py install for pep8 04:32:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:32 INFO - no previously-included directories found matching 'docs/_build' 04:32:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:32:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:32:32 INFO - Cleaning up... 04:32:32 INFO - Return code: 0 04:32:32 INFO - Running post-action listener: _resource_record_post_action 04:32:32 INFO - Running post-action listener: _start_resource_monitoring 04:32:32 INFO - Starting resource monitoring. 04:32:32 INFO - ##### 04:32:32 INFO - ##### Running install step. 04:32:32 INFO - ##### 04:32:32 INFO - Running pre-action listener: _resource_record_pre_action 04:32:32 INFO - Running main action method: install 04:32:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:32 INFO - Reading from file tmpfile_stdout 04:32:32 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:32 INFO - Reading from file tmpfile_stdout 04:32:32 INFO - Output received: 04:32:32 INFO - Usage: mozinstall [options] installer 04:32:32 INFO - Options: 04:32:32 INFO - -h, --help show this help message and exit 04:32:32 INFO - -d DEST, --destination=DEST 04:32:32 INFO - Directory to install application into. [default: 04:32:32 INFO - "/builds/slave/test"] 04:32:32 INFO - --app=APP Application being installed. [default: firefox] 04:32:32 INFO - mkdir: /builds/slave/test/build/application 04:32:32 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'] 04:32:32 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 04:33:06 INFO - Reading from file tmpfile_stdout 04:33:06 INFO - Output received: 04:33:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:33:06 INFO - Running post-action listener: _resource_record_post_action 04:33:06 INFO - ##### 04:33:06 INFO - ##### Running run-tests step. 04:33:06 INFO - ##### 04:33:06 INFO - Running pre-action listener: _resource_record_pre_action 04:33:06 INFO - Running main action method: run_tests 04:33:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:06 INFO - 2016-02-06 04:33:06.256 screenresolution[1657:8452] starting screenresolution argv=screenresolution get 04:33:06 INFO - 2016-02-06 04:33:06.258 screenresolution[1657:8452] Display 0: 1600x1200x32@60 04:33:06 INFO - 2016-02-06 04:33:06.264 screenresolution[1658:8454] starting screenresolution argv=screenresolution list 04:33:06 INFO - Available Modes on Display 0 04:33:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:06 INFO - Intel Iris: 04:33:06 INFO - Chipset Model: Intel Iris 04:33:06 INFO - Type: GPU 04:33:06 INFO - Bus: Built-In 04:33:06 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:06 INFO - Vendor: Intel (0x8086) 04:33:06 INFO - Device ID: 0x0a2e 04:33:06 INFO - Revision ID: 0x0009 04:33:06 INFO - Displays: 04:33:06 INFO - Display: 04:33:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:06 INFO - Display Serial Number: 1600x1200 60 04:33:06 INFO - Main Display: Yes 04:33:06 INFO - Mirror: Off 04:33:06 INFO - Online: Yes 04:33:06 INFO - Rotation: Supported 04:33:06 INFO - Return code: 0 04:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:06 INFO - Python 2.7.3 04:33:06 INFO - Return code: 0 04:33:06 INFO - grabbing minidump binary from tooltool 04:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:06 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 0x1060a3d30>, '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 0x105f06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106099b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33:06 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 04:33:06 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 04:33:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:06 INFO - Return code: 0 04:33:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:33:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:33:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:33:07 INFO - Return code: 0 04:33:07 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/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 04:33:07 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 http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/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 04:33:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUNaPTEP6B/Render', 04:33:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:07 INFO - 'HOME': '/Users/cltbld', 04:33:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:07 INFO - 'LOGNAME': 'cltbld', 04:33:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:07 INFO - 'MOZ_NO_REMOTE': '1', 04:33:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:07 INFO - 'NO_EM_RESTART': '1', 04:33:07 INFO - 'PAGER': '/bin/cat', 04:33:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:07 INFO - 'PWD': '/builds/slave/test', 04:33:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:07 INFO - 'SHELL': '/bin/bash', 04:33:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Es7X9hk15m/Listeners', 04:33:07 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 04:33:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:07 INFO - 'USER': 'cltbld', 04:33:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:07 INFO - 'XPC_FLAGS': '0x0', 04:33:07 INFO - 'XPC_SERVICE_NAME': '0', 04:33:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:07 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/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 04:33:08 INFO - mozversion application_buildid: 20160203075643 04:33:08 INFO - mozversion application_changeset: f5bd25c789b6bab468de449782b4985e39239968 04:33:08 INFO - mozversion application_display_name: Nightly 04:33:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:08 INFO - mozversion application_name: Firefox 04:33:08 INFO - mozversion application_remotingname: firefox 04:33:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:33:08 INFO - mozversion application_vendor: Mozilla 04:33:08 INFO - mozversion application_version: 47.0a1 04:33:08 INFO - mozversion platform_buildid: 20160203075643 04:33:08 INFO - mozversion platform_changeset: f5bd25c789b6bab468de449782b4985e39239968 04:33:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:33:08 INFO - mozversion platform_version: 47.0a1 04:33:08 INFO - using testdate: 1454761988 04:33:08 INFO - actual date: 1454761988 04:33:08 INFO - starting webserver on 'localhost:49279' 04:33:08 INFO - SUITE-START | Running 2 tests 04:33:08 INFO - TEST-START | dromaeo_css 04:33:08 INFO - operating with platform_type : mac_ 04:33:08 INFO - Initialising browser for dromaeo_css test... 04:33:08 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmp2a82m2/profile http://localhost:49279/getInfo.html) 04:33:08 INFO - PROCESS | 1676 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:33:11 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 04:33:11 INFO - PROCESS | 1676 | colorDepth:24 04:33:11 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 04:33:11 INFO - PROCESS | 1676 | __metrics 04:33:11 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2830: TypeError: this.tabs is undefined 04:33:11 INFO - PROCESS | 1676 | ************************* 04:33:11 INFO - PROCESS | 1676 | A coding exception was thrown in a Promise resolution callback. 04:33:11 INFO - PROCESS | 1676 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 04:33:11 INFO - PROCESS | 1676 | 04:33:11 ERROR - PROCESS | 1676 | Full message: TypeError: this.tabs is undefined 04:33:11 INFO - PROCESS | 1676 | Full stack: .get@chrome://browser/content/tabbrowser.xml:2830:17 04:33:11 INFO - PROCESS | 1676 | ssi_onClose/<@resource:///modules/sessionstore/SessionStore.jsm:1323:9 04:33:11 INFO - PROCESS | 1676 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 04:33:11 INFO - PROCESS | 1676 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 04:33:11 INFO - PROCESS | 1676 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 04:33:11 INFO - PROCESS | 1676 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 04:33:11 INFO - PROCESS | 1676 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 04:33:11 INFO - PROCESS | 1676 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:146:5 04:33:11 INFO - PROCESS | 1676 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:52:5 04:33:11 INFO - PROCESS | 1676 | receiveMessage@resource:///modules/sessionstore/SessionStore.jsm:734:11 04:33:11 INFO - PROCESS | 1676 | 04:33:11 INFO - PROCESS | 1676 | ************************* 04:33:11 INFO - PROCESS | 1676 | 04:33:11 INFO - PROCESS | 1676 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 04:33:11 INFO - PROCESS | 1676 | 04:33:11 INFO - TEST-INFO | 1676: exit 0 04:33:11 INFO - Browser initialized. 04:33:11 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:11 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmp2a82m2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:24 INFO - PROCESS | 1681 | RSS: Main: 257073152 04:33:24 INFO - PROCESS | 1681 | 04:34:13 INFO - PROCESS | 1681 | 1454762053762 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] 04:36:23 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 04:36:25 INFO - PROCESS | 1681 | RSS: Main: 271560704 04:36:25 INFO - PROCESS | 1681 | 04:39:28 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 04:39:28 INFO - PROCESS | 1681 | RSS: Main: 282464256 04:39:28 INFO - PROCESS | 1681 | 04:42:30 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 04:42:31 INFO - PROCESS | 1681 | RSS: Main: 283611136 04:42:31 INFO - PROCESS | 1681 | 04:45:32 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 04:45:33 INFO - PROCESS | 1681 | RSS: Main: 285663232 04:45:33 INFO - PROCESS | 1681 | 04:48:35 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 04:48:36 INFO - PROCESS | 1681 | RSS: Main: 288559104 04:48:36 INFO - PROCESS | 1681 | 04:51:38 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 04:51:39 INFO - PROCESS | 1681 | RSS: Main: 290422784 04:51:39 INFO - PROCESS | 1681 | 04:51:39 INFO - PROCESS | 1681 | __start_tp_report 04:51:39 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 04:51:39 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 04:51:39 INFO - PROCESS | 1681 | |i|pagename|runs| 04:51:39 INFO - PROCESS | 1681 | |0;dojo.html;3399.9999999999995;3450.1374656335915;3456.498807672889;3507.0530956641705;3515.8769443069496;5583.8604034899145;5635.239242702234;5637.210790489335;5644.491995720385;5648.830535083944;5511.283533140696;5616.803411880585;5640.125780504029;5701.857453563663;5757.769689212437;5114.974425127869;5124.333836601237;5169.767360468788;5229.660072095302;5246.1868410396255;4769.213079841822;5249.816256431026;5266.3153790007245;5286.682799032051;5292.470752924715;5065.493450654942;5069.239614057884;5179.14544100223;5198;5213.3743950725775;5133.537981581676;5142.871428214287;5163.8192663256605;5193.065248255312;5210.921836172461;5105.259737338065;5158.071547121516;5159.17453207485;5170.276161337416;5180.715060671661;4923.286123512106;5091.79632814687;5595.160725891108;5633.32400111985;5686.431356864322;6115.205023346981;6136.864680034208;6164.907526387108;6166.938330616681;6169.29053158888;6203.720832562545;6237.812865614039;6249.343818898996;6253.78111766086;6256.280527739323;5520.53075488588;5555.944440555623;5570.415106413809;5602.831915042555;5631;6294.181756371642;6316.936830631635;6332.081848131995;6344;6352.61884286935;5852.853678658068;5995.46040856325;6053.061775424816;6060.575759696867;6071.9696401518595;5224.8171314004585;6051.394860514001;6211.782587609412;6212.347703491158;6266.592671476339;6073.908891366633;6135.294441139326;6154.107654390178;6164.630122192682;6192.102145189013;6030.728617212236;6124.960759790135;6163.476104531165;6176.845578860564;6192.566520343623;4719.4100737407825;4872.975635121802;4873.683210591371;4886.364772579542;4906.2640603909695;4358.978205108954;4361.760103194355;4367.825286988548;4374.78126093694;4424.982254081515;5328.147496400557;5354.625176237704;5715.628484148517;5724.627899186539;5734.541236701054;5332.520073193431;6200.751969921243;6222.315545290015;6265.279492858289;6292;5759.712014399263;5767.106098554731;5779.855503612359;5782.219400380979;5854.531637468992;5212.947870521246;5249.632525723239;5271.130263506555;5290;5356.357237131491;6240.4071613196675;6243.907316219644;6253;6273.090401891792;6286.339934306832;6163.568550201443;6187;6191.318954914866;6196.47329976957;6204.937950620436;6127.922628246602;6195.96902015487;6221.160143380585;6230.595011324431;6260.217472815898;6102.298235702773;6111.174991376108;6152.261728592597;6164.4143806338325;6169.1054797053275;5141.691498510101;6051.939480605138;6238.126662267196;6260.906086408799;6262.749490020348;5862.325832529144;5913.911291330547;5918.082697181943;5933.436323549428;5934.762609495572;5900.43945825146;5901.409859014236;5906.852328691817;5907.49786268172;5927.170196172626;5730;5761.107028410603;5778.422157784188;5779.595428319977;5809.24479817621;4848.660593758403;5792.797252096157;5869.765209391577;5905.822825315247;5962.761489540369;5639.802606908738;5772.56705747079;5805.796797112081;5808.477237048517;5832.3292821326095 04:51:39 INFO - PROCESS | 1681 | |1;ext.html;454.6499195619371;498.9675671081379;515.8271978887072;547.7565925349456;566.959629080637;35938.46092308614;36601.81699091504;36899.81550092252;37064;37073;37953.810230948875;38373.808130959376;38454.61545384545;38563.03592410191;38786.8060659697;9357.25141988641;9485.905140948606;9531.761705957371;9532;9553.474558899257;9428.434293942351;9651.227901767841;9657.179139773092;9724.611015559405;9748.268879834006;8772.254358379545;9624.615015399375;9642.517874106301;9665.033496650349;9711.12599866012;9653.986331435204;9663.516824158763;9672.75818104553;9705.563249653782;9711.805763884753;9380.343375963685;9438.339316247866;9451.574679139456;9505.952470237604;9513.619455221782;34336.96989090331;34856.6514334856;37667.81166094152;37832.621673783186;37860.05349866248;3128.1710346758127;3163.5254711793414;3335.616404113534;3415;3622;22293.219737309115;27460.45079098427;27873.721262787316;28397.432051358857;28993.13020609385;2740.3560163361594;2809.5364264896266;2838.3755573773738;2862.728040836117;2880.438314528668;475838;475843;477883;481451.59274203755;481743;55177.72411137919;56701.86596268052;64626.676866615366;64818.67590662016;65346.69306613841;68482.3151768476;68663.65668171627;69046.65476672685;69705.3029469709;69823.95264071043;14060.648483787783;14748;14897.329620167118;16220.594485137966;16432.9318594291;11051.392173430539;12127.45426455794;12228.694282643006;12573.811392829115;12704.936475317565;16721.581960451087;19728.816271023785;20402.285919993024;20445.795542044685;20489.97550122488;8703.47779133254;8857.778555536035;8859.601317940707;8869.290456763443;8893.644254229888;925.3383830561181;943.7734943613483;978.7308490165261;1071.0735214039798;1151.6314779270554;26924;27224.319392015357;27345.863270683916;28065;28334.433311333658;1049.5329578337567;1060.7825395793843;1071.861636036113;1104.2380757277454;1197.479096592985;11891.762164756656;13005;13886.93056534711;14027.71944561103;14141.575752727435;403965;469123;470508.6474567605;474945;479835;50281;52403.73798131061;52866.47133528692;52997.47002530003;53037.469625304024;1391.6033930329806;1399.132537826554;1405.0445696926188;1427.9071860329252;1429.1282317786142;27507.724922751317;27615.58576621312;28129;30531.084067478012;30784.230394240323;50452.49547504625;50978.49021509737;51094.97810043704;51108.74445627748;51120;368873;373722;374337;374777;375431;36614.8169259152;41993;42776.14447711091;43733.56266437422;43809.56190438182;33211.667883321825;38626;38692.6130738689;38912.80543597264;39340;33847;35067.82466087653;35219;35405.29189416249;39305.41041884317;37560.24879502449;37989.81005094957;38051.42922856104;38161.80919095387;38412;37904.43143352797;38206;38238.6176138235;38349.2330153401;39676.404853927794;36894.63105368912;37729.62270377261;37888.62111378851;38091.80954095212;38566.42150367691;23093.19173828908;24629.876850615634;26705.732942670325;27051.1884643461;27506.587401188597 04:51:39 INFO - PROCESS | 1681 | |2;jquery.html;319.2481705583351;330.86103836388713;366.18158415940377;367.43231707012654;373.02640109314666;13998.30008499576;15045.699086018272;18497.815021849776;19021.619567608657;20321.491962700922;19355.806441935612;19603.41189764306;19701;19708.014599270016;19845.503862403446;4568.428946381702;5777.306723193223;5779.624324418899;5791.884162316751;5793.217915581406;4068.9186216275657;4254.744715317091;5392;6078.422549857779;6312.242530896299;6081.422264884829;6231.439170474657;6278.37216278373;6279.874402511947;6281.685915704196;6205.379462053781;6244.6253224806205;6244.750209991595;6260.718267677943;6278.277998030239;4157.0023194433425;5234.26720259164;5379.220013098079;5437.293151890229;5442;18803.811961880343;21052.368428947157;22781.202657906895;24300.78496075189;24487;2226.832987525942;2281.920132795344;2445.4864478459544;2871.0812539987214;2906.346072133774;11366.37484938328;11697.824532632018;14812.629684257872;14923.776143357858;15066.924665376713;1686.401327528734;1691.4587332053748;1745.642143360608;1779.0837718574944;1789.3021721528614;72079;89854.5507272466;92512;93229.53385233098;95046.52476737641;10362.171026318027;10616.734581635366;10769.192310576738;10786.029257366874;10853.565857365775;12745.17156384832;12804.935975320064;12937.964962802953;12948.935255323662;12960.675983100498;8126.959365203136;8306.003279606486;8351.665933362598;8446.155384461505;8457.577121143919;7388.224236455202;7909.694900341494;8471.110533394029;8513.489190648581;8536.701215457553;4000.8199631016673;4273.525633656383;4349.826006959686;4393.165298593257;4394.648428125743;1679.4709666455028;1778.1109445277361;1817.9909100454413;1826.9908650456662;1935.0614951748391;408.00446909540625;409.78076728949867;410.0896010855895;424.32744100600894;838.5597561280255;11305.321680699184;11554.133439991867;11601.593944211912;11696.70758231051;11735.295882247092;451.0527891427975;461.6491466485495;467.5698357511098;474.64662161826584;487.2934245344265;6022.427869352405;6180.47465965389;6181;6192.783252586228;6208.72060757267;590885;622667;625401;642033;662503;113473.43263283631;115207;115501.422492887;116573;116822;489.5887454538205;496.12434053894907;498.26505903792344;499.88752530681035;500.56200824278756;10854.860239674721;10956.34261944286;10976.396298203676;10998.890011099787;11053.778924421627;32445;47949.760251198524;49148;49362.75318623384;50224.497755021985;67738;67830.66084669743;68100;68434.3156568428;68817;7516.098068231847;7703.191164927826;7720.53676779395;7742.883856742266;7749.147593764794;10487.318324308895;10497.47512624381;10670.35977841332;11749.765004699688;11924.224925379822;9896.059874311928;9979.45113018791;10024.899751002396;10110;10156.644517441853;10000;10025.248106391904;10196.980301970041;10569;10704.732381690521;9840.852387214341;10182.745431364276;10451.372917624967;10454.215933804842;10494.737631558966;6836.453083753188;7121.540084282606;7465.552066876005;7553.093628764584;7639.85402189676;8310.626021829154;8764.553848615162;9813.067758562926;10023.949880250551;10334.483275836328 04:51:39 INFO - PROCESS | 1681 | |3;mootools.html;1461.232852752305;1535.523987563855;1748.484197161837;1876.999999999999;1884.4911873794085;7233.638318084095;7325.6703448344815;7812;8006.959965200181;8637.568121593926;8342;8453.196946290109;8481.067082620923;8553.61508732107;8607.526586037766;2425.1027119965593;2459.077845807822;2461.20010996426;2467.037855236459;2467.370820440785;2420.4311986683115;2454.1901172612993;2458.1273647855023;2459.311392810016;2461.1386014894824;2427.4949531290627;2441.6825812644333;2463.8398504097268;2473.1467643662995;2476.7275599684112;2436.5614189445805;2473.0478765675166;2478.529079474894;2479.429731161834;2485.291691867809;2435.476372579904;2442.5481285962155;2468.7160976487753;2471.5551200783852;2489.55188066148;8699.826003479959;8817.867731984026;8875;8877.955610221907;8890.4665720057;4903.313536104948;5324.1215199492035;5388.973055134738;5410.97294513525;5505.449455054502;3616.6202548732267;3694.9838794331504;3717.2937141942944;3719.977006323256;3763.379042457991;1046.487221261584;1068.1988508618535;1074.930129541585;1080.3140006096107;1103;11899.988500977428;11995.700107497383;12018.639440816789;12018.879811201863;12045.217060891015;3993.2213218422708;4918.409790825124;4930.630202734809;4949.802007919643;4955.132851751001;8390.874136887951;10189.337693049929;10203.28576999603;10244.53899574521;10269.897301027044;5365.597580181502;5421.756020979065;5437.592180586393;5445.646033007842;5495.697736624524;4450.577195166454;4586.174488592019;4854.68444551103;4991.800327986913;4995.600351971833;3916.706247031484;3961.425593288957;3966.2265858157957;4000.5199376075057;4013.5986401360215;1310.8951283897457;1325.8607846176205;1326.6882282663566;1330.5210124355224;1332.060897067565;1054.414799786126;1095.4686976816238;1321.73565286943;1360.8366995960548;1364.0792465086226;7991.360691144694;8081.191880811872;8091.231333023354;8124.878126828103;8142.470739402039;498.2799854210703;503.979840806371;506.0056988018561;1245.371087600774;1316.6379245707508;6229.906551401733;6284.057391391237;6335.11308416822;6353.650549219745;6355.618662880242;8975.28197744179;9428.10433008863;9991.100800927807;10463.84304235437;10808.675739727822;8113.269805717514;10312.639057632947;10542.156627469783;10666.36001839892;10687.83968240477;8065.9596702016115;8274.338052955749;8334.999800024036;8350.08149103598;8361.414700970874;7811.375089992901;7854.764357069297;8023.59882005909;8037.7588672339925;8050.315723163597;7929.960350198212;9133.45199288045;9465.290103242147;9471.10024547667;9555.331126821056;7672.693092276247;9175.357724959189;9513.904860951301;9705.854412183964;9813.460259685786;5432.782688692566;5994.250718660168;7102.218755936739;7419.99660091783;7444.478886477895;8142.8778568322705;8199.467034642728;8205.671773129008;8214.63034163476;8265.049519305116;6544.312847150981;7641.541507509567;7681.039870016248;7812.414068944966;7827.84344313122;7433.665485053294;7442.106947166375;7518.774436766906;7602.771916842504;7668.463207575416;7783.104942931409;7817.983662123887;7837.725679601414;7863.882041769492;7873.488223265469;7072.752453664097;7087.291270872872;7087.751928682677;7132.643367831484;7139.571625702474;7158.463115266271;7171.49799514029;7177.497575169897;7188.388986936169;7236.89144662841 04:51:39 INFO - PROCESS | 1681 | |4;prototype.html;327.3975884372754;331.9717823984961;333.62300600321635;337.6117464915348;341.79663100455235;6596.868062638744;6711.5301928865;6778.661066946657;6781.186257649083;6855.383015528601;6501.447376972963;6690.966545167267;6722.630255335955;6723.092382528357;6729.899051514231;4897.902041959159;4972.975135124319;5000.749812546864;5009;5028.647994640377;4907.411110666725;5007.824726134586;5017.297578339036;5018.949810501903;5045.1675473547;4976.950230497685;4990.176620857555;5007.874803129933;5015.398152221738;5022.321986531808;4998.700077995314;4999.725015124167;5010.248462730583;5018.64869459138;5023.070731914608;3419.9316013679836;4044.69664775143;4171.645410140141;4303.462067241595;4315.956840431587;5201.8959620807755;6405.647689377082;6437.227532696106;6445.548811583191;6446.709898054599;5304;5426.5077103796375;5932.436418540232;5934.139549765303;5935.643861368331;6966.965165174192;7225.277472252786;7236.746713864989;7251.492395532315;7252.782416527512;4801.135795556798;4801.255805350176;4803.423589169287;4810.302506136625;4814.470408255089;7626.42801789868;7647.235276472308;7673.386129109658;7689.577073260968;7693.615319234016;4724.314974328703;4865.148598995162;4884.169691152512;4887.902241955212;4900.583450406684;4178.895527611834;4948.876278093005;5006.874828129253;5007.273945277914;5011.198208286657;5924.081767326072;5926.466618004314;5928.229330187134;5932.555058370639;5942.970285148546;7235.855282894313;7261.673224704795;7282.453815963824;7290.8177295566975;7311.451641126937;1688.5272123805355;1710.8289171082793;1741.3208848549075;1743.7820272465942;1745.5723347779876;1120.8598925134359;1126.594426006637;1133.8696049954196;1138.538891748843;1139.9829002564968;6830.93169068303;6831.11195544576;6831.316868313228;6836.658167091626;6844.486663500257;7485.588292643848;7489.213632568501;7491.700331986768;7506.3244308012545;7514.211007844207;6735.393814556714;6808.2510923798345;6845.623490708059;6874.553154044971;6993.47548933832;3106.285554322473;3969.622885825842;3992.4610177626228;4053.0475338296064;4075.7554546726697;7786.961065194638;7839.412044096602;7966.442349035628;7998.480098793676;8001.039875215011;7908.881366779503;7917.376937727752;7923.12845586985;7925.088614809255;7926;7810.804729881685;7913.683452661944;7950.840983180304;7969.681212751541;7992.5204487730925;7627.618619068913;7632.274933881273;7632.5038872473115;7642.204082040605;7651.617419129133;7299.160596531467;7451.552906825608;7465.813354666177;7495;7507.136679281953;7970.760877173462;7977.082635496992;7985.800354991172;7985.920140798517;7993.240642138988;4711.717296962193;4756.381670382828;4768.237082066853;4770.642201834946;4783.976080119716;7304.269573042653;7602.50583712057;7607.657655405631;7624.5425274483705;7664.923350766421;7274.16347120088;7283.963580182065;7292.307230813064;7310.305520975498;7317.231690672403;5877;7252.347288743827;7270.636468176675;7271.563706177646;7279.59962202084;6320.336364681642;6450.387213214737;7110.822229444305;7123.715051397886;7147.1780745214965;7295.270472952662;7300.16048154469;7313.634318284171;7334.926650733424;7340.302671246223;6937.375636192767;7132;7133.500654954103;7151.749688760869;7173 04:51:39 INFO - PROCESS | 1681 | |5;yui.html;651.2347991110444;665.1120753793685;673.6699017481433;709.5671640299413;725.0243087586327;14490.565283041513;14746.262686865653;14796.964212505129;14847.480338188165;17001.82998170018;15546.922265388657;15618.297176627051;15618.453354132607;15638;15665.138417387068;699.6606645776794;854.6325080215505;866.6490071521013;869.9173578510031;871.9389642725012;704.1655638068879;845.1801752300258;866.7789713623017;871.2811930157613;872.110447343709;903.5437104262338;903.661127077346;907.7004588485817;909.3725329522641;910.4946754551221;886.2245535156737;901.4005686218657;903.4624398482893;907.1790030022839;911.4303560274828;659.9935098974103;665.3811954881958;668.759246671198;670.6814263224978;672.8385187554951;15154;15157.469488567958;15228.162451065187;15249.542513724606;15252.23738813066;12555.560555380518;12624.495020199181;12624.55814046504;12763.978881689443;13169.20984740909;9018.458892466473;9744.658936937172;10283.640072597424;11034.834477482844;11412.657620271406;3544.663256990582;3545.574531056264;3552.573691157052;3555;3602.189507360849;55034.44965550333;58230.41769582292;81080.59459702663;81417.59291203566;84515;9324.533773311307;9325.533723313807;9486.715398538056;9490.905090949002;9690.515474226402;20373.59252814965;20521.66609170399;20555.075021623765;20600.27899023527;20719.689204661943;5587;7452.85094298111;7646;7771.145174030852;7937.920620793718;3481.860725570949;4137.848676943306;4165.8958526037095;4193.832246710159;4289.656827453859;2873.6838947715733;3453.8791142309897;3535.575730912307;3553.058439513531;3615.475756015363;658.4173006888938;664.2062735031687;666.6033709942576;686.9141357330334;688.727952458786;479.7169669894709;583.375787906944;622.6544267931251;634.4828964394004;635.6345101566618;8245.492613412885;8766.824663506693;9263.980962094165;9314.767130821783;9316.767080823034;512.6693282832553;535.5602058931493;551.4595696217649;603.6016229288648;628.3841835001724;2915.897943572007;3808.695304375699;3884.188496215982;3986.2893232601527;4058.8579399721457;80603.5969820159;82741.3451730962;82791.17208827834;83374.58312708519;83410.58294708487;71806;72277;72319.63840180871;72915;73715.26284737191;63680.36319636837;63845;64253.357466425674;64529;64682.67658661676;8031.759047228593;8160.632771525415;8176.918230817853;8224.671013159646;8268.04021593789;37197.698080567054;37907.62092379041;38096;39243.60756392399;43587.9103022427;55945.16082258851;58512.12231816611;59230;59602.70198648979;60005.39994600173;9834.164096051916;9834.557444914853;9864.901350986398;9895.554700038372;9911.157551608194;10727.141828653845;10787;11617.941910290732;12004.579839705917;12765.93617031946;9302.720918372459;11620.489336386216;11659.88340116588;11813.881861181622;11927.926486616247;11704.122190835551;11705.707357316136;11785.528578857093;11911;12037.699057523281;11151.168945302566;11325;11384.43077846121;11425.828612570984;11676.94161529187;9162.348101329106;9526.333156678966;9618.230541556799;9649.807003860024;9693.224542036762;9507.239420846454;9825.852612210965;9872;9887.851682224917;9905.702828915144 04:51:39 INFO - PROCESS | 1681 | __end_tp_report 04:51:39 INFO - PROCESS | 1681 | __start_cc_report 04:51:39 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,365 04:51:39 INFO - PROCESS | 1681 | __end_cc_report 04:51:39 INFO - PROCESS | 1681 | __startTimestamp1454763099206__endTimestamp 04:51:39 INFO - PROCESS | 1681 | 04:51:39 INFO - PROCESS | 1681 | ------- Summary: start ------- 04:51:39 INFO - PROCESS | 1681 | Number of tests: 6 04:51:39 INFO - PROCESS | 1681 | 04:51:39 INFO - PROCESS | 1681 | [#0] dojo.html Cycles:165 Average:5644.78 Median:5779.86 stddev:624.04 (10.8%) stddev-sans-first:600.59 04:51:39 INFO - PROCESS | 1681 | Values: 3400.0 3450.1 3456.5 3507.1 3515.9 5583.9 5635.2 5637.2 5644.5 5648.8 5511.3 5616.8 5640.1 5701.9 5757.8 5115.0 5124.3 5169.8 5229.7 5246.2 4769.2 5249.8 5266.3 5286.7 5292.5 5065.5 5069.2 5179.1 5198.0 5213.4 5133.5 5142.9 5163.8 5193.1 5210.9 5105.3 5158.1 5159.2 5170.3 5180.7 4923.3 5091.8 5595.2 5633.3 5686.4 6115.2 6136.9 6164.9 6166.9 6169.3 6203.7 6237.8 6249.3 6253.8 6256.3 5520.5 5555.9 5570.4 5602.8 5631.0 6294.2 6316.9 6332.1 6344.0 6352.6 5852.9 5995.5 6053.1 6060.6 6072.0 5224.8 6051.4 6211.8 6212.3 6266.6 6073.9 6135.3 6154.1 6164.6 6192.1 6030.7 6125.0 6163.5 6176.8 6192.6 4719.4 4873.0 4873.7 4886.4 4906.3 4359.0 4361.8 4367.8 4374.8 4425.0 5328.1 5354.6 5715.6 5724.6 5734.5 5332.5 6200.8 6222.3 6265.3 6292.0 5759.7 5767.1 5779.9 5782.2 5854.5 5212.9 5249.6 5271.1 5290.0 5356.4 6240.4 6243.9 6253.0 6273.1 6286.3 6163.6 6187.0 6191.3 6196.5 6204.9 6127.9 6196.0 6221.2 6230.6 6260.2 6102.3 6111.2 6152.3 6164.4 6169.1 5141.7 6051.9 6238.1 6260.9 6262.7 5862.3 5913.9 5918.1 5933.4 5934.8 5900.4 5901.4 5906.9 5907.5 5927.2 5730.0 5761.1 5778.4 5779.6 5809.2 4848.7 5792.8 5869.8 5905.8 5962.8 5639.8 5772.6 5805.8 5808.5 5832.3 04:51:39 INFO - PROCESS | 1681 | 04:51:39 INFO - PROCESS | 1681 | [#1] ext.html Cycles:180 Average:58976.42 Median:38071.62 stddev:116602.03 (306.3%) stddev-sans-first:116846.34 04:51:39 INFO - PROCESS | 1681 | Values: 454.6 499.0 515.8 547.8 567.0 35938.5 36601.8 36899.8 37064.0 37073.0 37953.8 38373.8 38454.6 38563.0 38786.8 9357.3 9485.9 9531.8 9532.0 9553.5 9428.4 9651.2 9657.2 9724.6 9748.3 8772.3 9624.6 9642.5 9665.0 9711.1 9654.0 9663.5 9672.8 9705.6 9711.8 9380.3 9438.3 9451.6 9506.0 9513.6 34337.0 34856.7 37667.8 37832.6 37860.1 3128.2 3163.5 3335.6 3415.0 3622.0 22293.2 27460.5 27873.7 28397.4 28993.1 2740.4 2809.5 2838.4 2862.7 2880.4 475838.0 475843.0 477883.0 481451.6 481743.0 55177.7 56701.9 64626.7 64818.7 65346.7 68482.3 68663.7 69046.7 69705.3 69824.0 14060.6 14748.0 14897.3 16220.6 16432.9 11051.4 12127.5 12228.7 12573.8 12704.9 16721.6 19728.8 20402.3 20445.8 20490.0 8703.5 8857.8 8859.6 8869.3 8893.6 925.3 943.8 978.7 1071.1 1151.6 26924.0 27224.3 27345.9 28065.0 28334.4 1049.5 1060.8 1071.9 1104.2 1197.5 11891.8 13005.0 13886.9 14027.7 14141.6 403965.0 469123.0 470508.6 474945.0 479835.0 50281.0 52403.7 52866.5 52997.5 53037.5 1391.6 1399.1 1405.0 1427.9 1429.1 27507.7 27615.6 28129.0 30531.1 30784.2 50452.5 50978.5 51095.0 51108.7 51120.0 368873.0 373722.0 374337.0 374777.0 375431.0 36614.8 41993.0 42776.1 43733.6 43809.6 33211.7 38626.0 38692.6 38912.8 39340.0 33847.0 35067.8 35219.0 35405.3 39305.4 37560.2 37989.8 38051.4 38161.8 38412.0 37904.4 38206.0 38238.6 38349.2 39676.4 36894.6 37729.6 37888.6 38091.8 38566.4 23093.2 24629.9 26705.7 27051.2 27506.6 04:51:39 INFO - PROCESS | 1681 | 04:51:39 INFO - PROCESS | 1681 | [#2] jquery.html Cycles:180 Average:33197.51 Median:2290.66 stddev:103987.61 (4539.6%) stddev-sans-first:104250.01 04:51:39 INFO - PROCESS | 1681 | Values: 319.2 330.9 366.2 367.4 373.0 13998.3 15045.7 18497.8 19021.6 20321.5 19355.8 19603.4 19701.0 19708.0 19845.5 4568.4 5777.3 5779.6 5791.9 5793.2 4068.9 4254.7 5392.0 6078.4 6312.2 6081.4 6231.4 6278.4 6279.9 6281.7 6205.4 6244.6 6244.8 6260.7 6278.3 4157.0 5234.3 5379.2 5437.3 5442.0 18803.8 21052.4 22781.2 24300.8 24487.0 2226.8 2281.9 2445.5 2871.1 2906.3 11366.4 11697.8 14812.6 14923.8 15066.9 1686.4 1691.5 1745.6 1779.1 1789.3 72079.0 89854.6 92512.0 93229.5 95046.5 10362.2 10616.7 10769.2 10786.0 10853.6 12745.2 12804.9 12938.0 12948.9 12960.7 8127.0 8306.0 8351.7 8446.2 8457.6 7388.2 7909.7 8471.1 8513.5 8536.7 4000.8 4273.5 4349.8 4393.2 4394.6 1679.5 1778.1 1818.0 1827.0 1935.1 408.0 409.8 410.1 424.3 838.6 11305.3 11554.1 11601.6 11696.7 11735.3 451.1 461.6 467.6 474.6 487.3 6022.4 6180.5 6181.0 6192.8 6208.7 590885.0 622667.0 625401.0 642033.0 662503.0 113473.4 115207.0 115501.4 116573.0 116822.0 489.6 496.1 498.3 499.9 500.6 10854.9 10956.3 10976.4 10998.9 11053.8 32445.0 47949.8 49148.0 49362.8 50224.5 67738.0 67830.7 68100.0 68434.3 68817.0 7516.1 7703.2 7720.5 7742.9 7749.1 10487.3 10497.5 10670.4 11749.8 11924.2 9896.1 9979.5 10024.9 10110.0 10156.6 10000.0 10025.2 10197.0 10569.0 10704.7 9840.9 10182.7 10451.4 10454.2 10494.7 6836.5 7121.5 7465.6 7553.1 7639.9 8310.6 8764.6 9813.1 10023.9 10334.5 04:51:39 INFO - PROCESS | 1681 | 04:51:39 INFO - PROCESS | 1681 | [#3] mootools.html Cycles:180 Average:5953.55 Median:5427.27 stddev:3100.09 (57.1%) stddev-sans-first:3090.40 04:51:39 INFO - PROCESS | 1681 | Values: 1461.2 1535.5 1748.5 1877.0 1884.5 7233.6 7325.7 7812.0 8007.0 8637.6 8342.0 8453.2 8481.1 8553.6 8607.5 2425.1 2459.1 2461.2 2467.0 2467.4 2420.4 2454.2 2458.1 2459.3 2461.1 2427.5 2441.7 2463.8 2473.1 2476.7 2436.6 2473.0 2478.5 2479.4 2485.3 2435.5 2442.5 2468.7 2471.6 2489.6 8699.8 8817.9 8875.0 8878.0 8890.5 4903.3 5324.1 5389.0 5411.0 5505.4 3616.6 3695.0 3717.3 3720.0 3763.4 1046.5 1068.2 1074.9 1080.3 1103.0 11900.0 11995.7 12018.6 12018.9 12045.2 3993.2 4918.4 4930.6 4949.8 4955.1 8390.9 10189.3 10203.3 10244.5 10269.9 5365.6 5421.8 5437.6 5445.6 5495.7 4450.6 4586.2 4854.7 4991.8 4995.6 3916.7 3961.4 3966.2 4000.5 4013.6 1310.9 1325.9 1326.7 1330.5 1332.1 1054.4 1095.5 1321.7 1360.8 1364.1 7991.4 8081.2 8091.2 8124.9 8142.5 498.3 504.0 506.0 1245.4 1316.6 6229.9 6284.1 6335.1 6353.7 6355.6 8975.3 9428.1 9991.1 10463.8 10808.7 8113.3 10312.6 10542.2 10666.4 10687.8 8066.0 8274.3 8335.0 8350.1 8361.4 7811.4 7854.8 8023.6 8037.8 8050.3 7930.0 9133.5 9465.3 9471.1 9555.3 7672.7 9175.4 9513.9 9705.9 9813.5 5432.8 5994.3 7102.2 7420.0 7444.5 8142.9 8199.5 8205.7 8214.6 8265.0 6544.3 7641.5 7681.0 7812.4 7827.8 7433.7 7442.1 7518.8 7602.8 7668.5 7783.1 7818.0 7837.7 7863.9 7873.5 7072.8 7087.3 7087.8 7132.6 7139.6 7158.5 7171.5 7177.5 7188.4 7236.9 04:51:39 INFO - PROCESS | 1681 | 04:51:39 INFO - PROCESS | 1681 | [#4] prototype.html Cycles:180 Average:5966.93 Median:6757.03 stddev:1923.77 (28.5%) stddev-sans-first:1882.02 04:51:39 INFO - PROCESS | 1681 | Values: 327.4 332.0 333.6 337.6 341.8 6596.9 6711.5 6778.7 6781.2 6855.4 6501.4 6691.0 6722.6 6723.1 6729.9 4897.9 4973.0 5000.7 5009.0 5028.6 4907.4 5007.8 5017.3 5018.9 5045.2 4977.0 4990.2 5007.9 5015.4 5022.3 4998.7 4999.7 5010.2 5018.6 5023.1 3419.9 4044.7 4171.6 4303.5 4316.0 5201.9 6405.6 6437.2 6445.5 6446.7 5304.0 5426.5 5932.4 5934.1 5935.6 6967.0 7225.3 7236.7 7251.5 7252.8 4801.1 4801.3 4803.4 4810.3 4814.5 7626.4 7647.2 7673.4 7689.6 7693.6 4724.3 4865.1 4884.2 4887.9 4900.6 4178.9 4948.9 5006.9 5007.3 5011.2 5924.1 5926.5 5928.2 5932.6 5943.0 7235.9 7261.7 7282.5 7290.8 7311.5 1688.5 1710.8 1741.3 1743.8 1745.6 1120.9 1126.6 1133.9 1138.5 1140.0 6830.9 6831.1 6831.3 6836.7 6844.5 7485.6 7489.2 7491.7 7506.3 7514.2 6735.4 6808.3 6845.6 6874.6 6993.5 3106.3 3969.6 3992.5 4053.0 4075.8 7787.0 7839.4 7966.4 7998.5 8001.0 7908.9 7917.4 7923.1 7925.1 7926.0 7810.8 7913.7 7950.8 7969.7 7992.5 7627.6 7632.3 7632.5 7642.2 7651.6 7299.2 7451.6 7465.8 7495.0 7507.1 7970.8 7977.1 7985.8 7985.9 7993.2 4711.7 4756.4 4768.2 4770.6 4784.0 7304.3 7602.5 7607.7 7624.5 7664.9 7274.2 7284.0 7292.3 7310.3 7317.2 5877.0 7252.3 7270.6 7271.6 7279.6 6320.3 6450.4 7110.8 7123.7 7147.2 7295.3 7300.2 7313.6 7334.9 7340.3 6937.4 7132.0 7133.5 7151.7 7173.0 04:51:39 INFO - PROCESS | 1681 | 04:51:39 INFO - PROCESS | 1681 | [#5] yui.html Cycles:180 Average:16930.04 Median:63762.68 stddev:22916.28 (35.9%) stddev-sans-first:22947.97 04:51:39 INFO - PROCESS | 1681 | Values: 651.2 665.1 673.7 709.6 725.0 14490.6 14746.3 14797.0 14847.5 17001.8 15546.9 15618.3 15618.5 15638.0 15665.1 699.7 854.6 866.6 869.9 871.9 704.2 845.2 866.8 871.3 872.1 903.5 903.7 907.7 909.4 910.5 886.2 901.4 903.5 907.2 911.4 660.0 665.4 668.8 670.7 672.8 15154.0 15157.5 15228.2 15249.5 15252.2 12555.6 12624.5 12624.6 12764.0 13169.2 9018.5 9744.7 10283.6 11034.8 11412.7 3544.7 3545.6 3552.6 3555.0 3602.2 55034.4 58230.4 81080.6 81417.6 84515.0 9324.5 9325.5 9486.7 9490.9 9690.5 20373.6 20521.7 20555.1 20600.3 20719.7 5587.0 7452.9 7646.0 7771.1 7937.9 3481.9 4137.8 4165.9 4193.8 4289.7 2873.7 3453.9 3535.6 3553.1 3615.5 658.4 664.2 666.6 686.9 688.7 479.7 583.4 622.7 634.5 635.6 8245.5 8766.8 9264.0 9314.8 9316.8 512.7 535.6 551.5 603.6 628.4 2915.9 3808.7 3884.2 3986.3 4058.9 80603.6 82741.3 82791.2 83374.6 83410.6 71806.0 72277.0 72319.6 72915.0 73715.3 63680.4 63845.0 64253.4 64529.0 64682.7 8031.8 8160.6 8176.9 8224.7 8268.0 37197.7 37907.6 38096.0 39243.6 43587.9 55945.2 58512.1 59230.0 59602.7 60005.4 9834.2 9834.6 9864.9 9895.6 9911.2 10727.1 10787.0 11617.9 12004.6 12765.9 9302.7 11620.5 11659.9 11813.9 11927.9 11704.1 11705.7 11785.5 11911.0 12037.7 11151.2 11325.0 11384.4 11425.8 11676.9 9162.3 9526.3 9618.2 9649.8 9693.2 9507.2 9825.9 9872.0 9887.9 9905.7 04:51:39 INFO - PROCESS | 1681 | -------- Summary: end -------- 04:51:39 INFO - PROCESS | 1681 | 04:51:39 INFO - TEST-INFO | 1681: exit 0 04:51:39 INFO - TEST-OK | dromaeo_css | took 1111590ms 04:51:39 INFO - TEST-START | kraken 04:51:39 INFO - operating with platform_type : mac_ 04:51:39 INFO - Initialising browser for kraken test... 04:51:39 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpL4jrAa/profile http://localhost:49279/getInfo.html) 04:51:39 INFO - PROCESS | 1690 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:51:42 INFO - PROCESS | 1690 | __metrics Screen width/height:1600/1200 04:51:42 INFO - PROCESS | 1690 | colorDepth:24 04:51:42 INFO - PROCESS | 1690 | Browser inner width/height: 1024/689 04:51:42 INFO - PROCESS | 1690 | __metrics 04:51:42 ERROR - PROCESS | 1690 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2830: TypeError: this.tabs is undefined 04:51:42 INFO - PROCESS | 1690 | ************************* 04:51:42 INFO - PROCESS | 1690 | A coding exception was thrown in a Promise resolution callback. 04:51:42 INFO - PROCESS | 1690 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 04:51:42 INFO - PROCESS | 1690 | 04:51:42 ERROR - PROCESS | 1690 | Full message: TypeError: this.tabs is undefined 04:51:42 INFO - PROCESS | 1690 | Full stack: .get@chrome://browser/content/tabbrowser.xml:2830:17 04:51:42 INFO - PROCESS | 1690 | ssi_onClose/<@resource:///modules/sessionstore/SessionStore.jsm:1323:9 04:51:42 INFO - PROCESS | 1690 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 04:51:42 INFO - PROCESS | 1690 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 04:51:42 INFO - PROCESS | 1690 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 04:51:42 INFO - PROCESS | 1690 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 04:51:42 INFO - PROCESS | 1690 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 04:51:42 INFO - PROCESS | 1690 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:146:5 04:51:42 INFO - PROCESS | 1690 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:52:5 04:51:42 INFO - PROCESS | 1690 | receiveMessage@resource:///modules/sessionstore/SessionStore.jsm:734:11 04:51:42 INFO - PROCESS | 1690 | 04:51:42 INFO - PROCESS | 1690 | ************************* 04:51:43 INFO - TEST-INFO | 1690: exit 0 04:51:43 INFO - Browser initialized. 04:51:43 INFO - Running cycle 1/1 for kraken test... 04:51:43 INFO - TEST-INFO | started process 1693 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpL4jrAa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:55 INFO - PROCESS | 1693 | RSS: Main: 256618496 04:51:55 INFO - PROCESS | 1693 | 04:51:58 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:58 INFO - PROCESS | 1693 | RSS: Main: 269918208 04:51:58 INFO - PROCESS | 1693 | 04:52:01 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 04:52:02 INFO - PROCESS | 1693 | RSS: Main: 277696512 04:52:02 INFO - PROCESS | 1693 | 04:52:05 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 04:52:05 INFO - PROCESS | 1693 | RSS: Main: 282443776 04:52:05 INFO - PROCESS | 1693 | 04:52:07 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 04:52:08 INFO - PROCESS | 1693 | RSS: Main: 281329664 04:52:08 INFO - PROCESS | 1693 | 04:52:10 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:11 INFO - PROCESS | 1693 | RSS: Main: 281706496 04:52:11 INFO - PROCESS | 1693 | 04:52:13 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:14 INFO - PROCESS | 1693 | RSS: Main: 283533312 04:52:14 INFO - PROCESS | 1693 | 04:52:17 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:18 INFO - PROCESS | 1693 | RSS: Main: 284745728 04:52:18 INFO - PROCESS | 1693 | 04:52:21 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 04:52:21 INFO - PROCESS | 1693 | RSS: Main: 285351936 04:52:21 INFO - PROCESS | 1693 | 04:52:23 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:23 INFO - PROCESS | 1693 | RSS: Main: 285044736 04:52:23 INFO - PROCESS | 1693 | 04:52:25 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:26 INFO - PROCESS | 1693 | RSS: Main: 283246592 04:52:26 INFO - PROCESS | 1693 | 04:52:28 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:29 INFO - PROCESS | 1693 | RSS: Main: 283770880 04:52:29 INFO - PROCESS | 1693 | 04:52:31 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:32 INFO - PROCESS | 1693 | RSS: Main: 283795456 04:52:32 INFO - PROCESS | 1693 | 04:52:34 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:35 INFO - PROCESS | 1693 | RSS: Main: 285007872 04:52:35 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 04:52:37 INFO - PROCESS | 1693 | RSS: Main: 286277632 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | __start_tp_report 04:52:37 INFO - PROCESS | 1693 | _x_x_mozilla_page_load 04:52:37 INFO - PROCESS | 1693 | _x_x_mozilla_page_load_details 04:52:37 INFO - PROCESS | 1693 | |i|pagename|runs| 04:52:37 INFO - PROCESS | 1693 | |0;ai-astar;113;109;114;114;114;127;123;165;126;115 04:52:37 INFO - PROCESS | 1693 | |1;audio-beat-detection;158;159;186;151;123;141;133;190;174;108 04:52:37 INFO - PROCESS | 1693 | |2;audio-dft;193;192;195;217;221;193;198;192;228;274 04:52:37 INFO - PROCESS | 1693 | |3;audio-fft;65;72;77;112;58;58;60;59;111;58 04:52:37 INFO - PROCESS | 1693 | |4;audio-oscillator;87;85;118;79;80;88;113;81;82;110 04:52:37 INFO - PROCESS | 1693 | |5;imaging-gaussian-blur;88;92;74;124;133;94;88;129;87;91 04:52:37 INFO - PROCESS | 1693 | |6;imaging-darkroom;105;150;151;112;95;95;97;95;98;96 04:52:37 INFO - PROCESS | 1693 | |7;imaging-desaturate;94;125;149;95;107;98;120;123;96;91 04:52:37 INFO - PROCESS | 1693 | |8;json-parse-financial;49;57;83;83;56;56;53;72;65;47 04:52:37 INFO - PROCESS | 1693 | |9;json-stringify-tinderbox;68;86;84;74;72;74;97;98;83;64 04:52:37 INFO - PROCESS | 1693 | |10;stanford-crypto-aes;95;86;87;82;86;85;85;83;87;83 04:52:37 INFO - PROCESS | 1693 | |11;stanford-crypto-ccm;135;133;136;148;138;133;115;122;132;125 04:52:37 INFO - PROCESS | 1693 | |12;stanford-crypto-pbkdf2;145;142;145;141;142;143;139;138;142;137 04:52:37 INFO - PROCESS | 1693 | |13;stanford-crypto-sha256-iterative;68;68;61;55;74;97;93;97;70;68 04:52:37 INFO - PROCESS | 1693 | __end_tp_report 04:52:37 INFO - PROCESS | 1693 | __start_cc_report 04:52:37 INFO - PROCESS | 1693 | _x_x_mozilla_cycle_collect,910 04:52:37 INFO - PROCESS | 1693 | __end_cc_report 04:52:37 INFO - PROCESS | 1693 | __startTimestamp1454763157433__endTimestamp 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | ------- Summary: start ------- 04:52:37 INFO - PROCESS | 1693 | Number of tests: 14 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | [#0] ai-astar Cycles:10 Average:122.00 Median:119.00 stddev:16.27 (13.7%) stddev-sans-first:16.93 04:52:37 INFO - PROCESS | 1693 | Values: 113.0 109.0 114.0 114.0 114.0 127.0 123.0 165.0 126.0 115.0 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:158.50 stddev:26.73 (16.9%) stddev-sans-first:28.27 04:52:37 INFO - PROCESS | 1693 | Values: 158.0 159.0 186.0 151.0 123.0 141.0 133.0 190.0 174.0 108.0 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | [#2] audio-dft Cycles:10 Average:210.30 Median:207.50 stddev:26.21 (12.6%) stddev-sans-first:27.05 04:52:37 INFO - PROCESS | 1693 | Values: 193.0 192.0 195.0 217.0 221.0 193.0 198.0 192.0 228.0 274.0 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | [#3] audio-fft Cycles:10 Average:73.00 Median:59.50 stddev:21.31 (35.8%) stddev-sans-first:22.40 04:52:37 INFO - PROCESS | 1693 | Values: 65.0 72.0 77.0 112.0 58.0 58.0 60.0 59.0 111.0 58.0 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:81.50 stddev:15.14 (18.6%) stddev-sans-first:15.94 04:52:37 INFO - PROCESS | 1693 | Values: 87.0 85.0 118.0 79.0 80.0 88.0 113.0 81.0 82.0 110.0 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | [#5] imaging-gaussian-blur Cycles:10 Average:100.00 Median:88.00 stddev:20.60 (23.4%) stddev-sans-first:21.39 04:52:37 INFO - PROCESS | 1693 | Values: 88.0 92.0 74.0 124.0 133.0 94.0 88.0 129.0 87.0 91.0 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | [#6] imaging-darkroom Cycles:10 Average:109.40 Median:95.00 stddev:22.34 (23.5%) stddev-sans-first:23.63 04:52:37 INFO - PROCESS | 1693 | Values: 105.0 150.0 151.0 112.0 95.0 95.0 97.0 95.0 98.0 96.0 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | [#7] imaging-desaturate Cycles:10 Average:109.80 Median:92.50 stddev:18.87 (20.4%) stddev-sans-first:19.13 04:52:37 INFO - PROCESS | 1693 | Values: 94.0 125.0 149.0 95.0 107.0 98.0 120.0 123.0 96.0 91.0 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:61.00 stddev:13.18 (21.6%) stddev-sans-first:13.10 04:52:37 INFO - PROCESS | 1693 | Values: 49.0 57.0 83.0 83.0 56.0 56.0 53.0 72.0 65.0 47.0 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:83.50 stddev:11.60 (13.9%) stddev-sans-first:11.46 04:52:37 INFO - PROCESS | 1693 | Values: 68.0 86.0 84.0 74.0 72.0 74.0 97.0 98.0 83.0 64.0 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:3.63 (4.2%) stddev-sans-first:1.83 04:52:37 INFO - PROCESS | 1693 | Values: 95.0 86.0 87.0 82.0 86.0 85.0 85.0 83.0 87.0 83.0 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:134.00 stddev:9.17 (6.8%) stddev-sans-first:9.64 04:52:37 INFO - PROCESS | 1693 | Values: 135.0 133.0 136.0 148.0 138.0 133.0 115.0 122.0 132.0 125.0 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:142.00 stddev:2.72 (1.9%) stddev-sans-first:2.55 04:52:37 INFO - PROCESS | 1693 | Values: 145.0 142.0 145.0 141.0 142.0 143.0 139.0 138.0 142.0 137.0 04:52:37 INFO - PROCESS | 1693 | 04:52:37 INFO - PROCESS | 1693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:72.00 stddev:15.13 (21.0%) stddev-sans-first:15.83 04:52:37 INFO - PROCESS | 1693 | Values: 68.0 68.0 61.0 55.0 74.0 97.0 93.0 97.0 70.0 68.0 04:52:37 INFO - PROCESS | 1693 | -------- Summary: end -------- 04:52:37 INFO - PROCESS | 1693 | 04:52:38 INFO - TEST-INFO | 1693: exit 0 04:52:38 INFO - TEST-OK | kraken | took 58589ms 04:52:38 INFO - SUITE-END | took 1170s 04:52:38 INFO - Completed test suite (00:19:30) 04:52:38 INFO - Working with test: dromaeo_css 04:52:38 INFO - Generating results file: dromaeo_css 04:52:38 INFO - Working with test: kraken 04:52:38 INFO - Generating results file: kraken 04:52:38 INFO - javascript benchmark 04:52:38 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:52:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 04:52:39 INFO - process_Request line: dromaeo_css 7323.22 graph.html#tests=[[72,64,61]] 04:52:39 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:52:39 INFO - process_Request line: kraken 1545.30 graph.html#tests=[[232,64,61]] 04:52:39 INFO - RETURN: dromaeo_css: 7323.22 04:52:39 INFO - RETURN: kraken: 1545.30 04:52:39 INFO - javascript benchmark 04:52:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3399.9999999999995, 3450.1374656335915, 3456.498807672889, 3507.0530956641705, 3515.8769443069496, 5583.8604034899145, 5635.239242702234, 5637.210790489335, 5644.491995720385, 5648.830535083944, 5511.283533140696, 5616.803411880585, 5640.125780504029, 5701.857453563663, 5757.769689212437, 5114.974425127869, 5124.333836601237, 5169.767360468788, 5229.660072095302, 5246.1868410396255, 4769.213079841822, 5249.816256431026, 5266.3153790007245, 5286.682799032051, 5292.470752924715, 5065.493450654942, 5069.239614057884, 5179.14544100223, 5198.0, 5213.3743950725775, 5133.537981581676, 5142.871428214287, 5163.8192663256605, 5193.065248255312, 5210.921836172461, 5105.259737338065, 5158.071547121516, 5159.17453207485, 5170.276161337416, 5180.715060671661, 4923.286123512106, 5091.79632814687, 5595.160725891108, 5633.32400111985, 5686.431356864322, 6115.205023346981, 6136.864680034208, 6164.907526387108, 6166.938330616681, 6169.29053158888, 6203.720832562545, 6237.812865614039, 6249.343818898996, 6253.78111766086, 6256.280527739323, 5520.53075488588, 5555.944440555623, 5570.415106413809, 5602.831915042555, 5631.0, 6294.181756371642, 6316.936830631635, 6332.081848131995, 6344.0, 6352.61884286935, 5852.853678658068, 5995.46040856325, 6053.061775424816, 6060.575759696867, 6071.9696401518595, 5224.8171314004585, 6051.394860514001, 6211.782587609412, 6212.347703491158, 6266.592671476339, 6073.908891366633, 6135.294441139326, 6154.107654390178, 6164.630122192682, 6192.102145189013, 6030.728617212236, 6124.960759790135, 6163.476104531165, 6176.845578860564, 6192.566520343623, 4719.4100737407825, 4872.975635121802, 4873.683210591371, 4886.364772579542, 4906.2640603909695, 4358.978205108954, 4361.760103194355, 4367.825286988548, 4374.78126093694, 4424.982254081515, 5328.147496400557, 5354.625176237704, 5715.628484148517, 5724.627899186539, 5734.541236701054, 5332.520073193431, 6200.751969921243, 6222.315545290015, 6265.279492858289, 6292.0, 5759.712014399263, 5767.106098554731, 5779.855503612359, 5782.219400380979, 5854.531637468992, 5212.947870521246, 5249.632525723239, 5271.130263506555, 5290.0, 5356.357237131491, 6240.4071613196675, 6243.907316219644, 6253.0, 6273.090401891792, 6286.339934306832, 6163.568550201443, 6187.0, 6191.318954914866, 6196.47329976957, 6204.937950620436, 6127.922628246602, 6195.96902015487, 6221.160143380585, 6230.595011324431, 6260.217472815898, 6102.298235702773, 6111.174991376108, 6152.261728592597, 6164.4143806338325, 6169.1054797053275, 5141.691498510101, 6051.939480605138, 6238.126662267196, 6260.906086408799, 6262.749490020348, 5862.325832529144, 5913.911291330547, 5918.082697181943, 5933.436323549428, 5934.762609495572, 5900.43945825146, 5901.409859014236, 5906.852328691817, 5907.49786268172, 5927.170196172626, 5730.0, 5761.107028410603, 5778.422157784188, 5779.595428319977, 5809.24479817621, 4848.660593758403, 5792.797252096157, 5869.765209391577, 5905.822825315247, 5962.761489540369, 5639.802606908738, 5772.56705747079, 5805.796797112081, 5808.477237048517, 5832.3292821326095], "unit": "score", "name": "dojo.html", "value": 5607.682648267647}, {"lowerIsBetter": false, "replicates": [454.6499195619371, 498.9675671081379, 515.8271978887072, 547.7565925349456, 566.959629080637, 35938.46092308614, 36601.81699091504, 36899.81550092252, 37064.0, 37073.0, 37953.810230948875, 38373.808130959376, 38454.61545384545, 38563.03592410191, 38786.8060659697, 9357.25141988641, 9485.905140948606, 9531.761705957371, 9532.0, 9553.474558899257, 9428.434293942351, 9651.227901767841, 9657.179139773092, 9724.611015559405, 9748.268879834006, 8772.254358379545, 9624.615015399375, 9642.517874106301, 9665.033496650349, 9711.12599866012, 9653.986331435204, 9663.516824158763, 9672.75818104553, 9705.563249653782, 9711.805763884753, 9380.343375963685, 9438.339316247866, 9451.574679139456, 9505.952470237604, 9513.619455221782, 34336.96989090331, 34856.6514334856, 37667.81166094152, 37832.621673783186, 37860.05349866248, 3128.1710346758127, 3163.5254711793414, 3335.616404113534, 3415.0, 3622.0, 22293.219737309115, 27460.45079098427, 27873.721262787316, 28397.432051358857, 28993.13020609385, 2740.3560163361594, 2809.5364264896266, 2838.3755573773738, 2862.728040836117, 2880.438314528668, 475838.0, 475843.0, 477883.0, 481451.59274203755, 481743.0, 55177.72411137919, 56701.86596268052, 64626.676866615366, 64818.67590662016, 65346.69306613841, 68482.3151768476, 68663.65668171627, 69046.65476672685, 69705.3029469709, 69823.95264071043, 14060.648483787783, 14748.0, 14897.329620167118, 16220.594485137966, 16432.9318594291, 11051.392173430539, 12127.45426455794, 12228.694282643006, 12573.811392829115, 12704.936475317565, 16721.581960451087, 19728.816271023785, 20402.285919993024, 20445.795542044685, 20489.97550122488, 8703.47779133254, 8857.778555536035, 8859.601317940707, 8869.290456763443, 8893.644254229888, 925.3383830561181, 943.7734943613483, 978.7308490165261, 1071.0735214039798, 1151.6314779270554, 26924.0, 27224.319392015357, 27345.863270683916, 28065.0, 28334.433311333658, 1049.5329578337567, 1060.7825395793843, 1071.861636036113, 1104.2380757277454, 1197.479096592985, 11891.762164756656, 13005.0, 13886.93056534711, 14027.71944561103, 14141.575752727435, 403965.0, 469123.0, 470508.6474567605, 474945.0, 479835.0, 50281.0, 52403.73798131061, 52866.47133528692, 52997.47002530003, 53037.469625304024, 1391.6033930329806, 1399.132537826554, 1405.0445696926188, 1427.9071860329252, 1429.1282317786142, 27507.724922751317, 27615.58576621312, 28129.0, 30531.084067478012, 30784.230394240323, 50452.49547504625, 50978.49021509737, 51094.97810043704, 51108.74445627748, 51120.0, 368873.0, 373722.0, 374337.0, 374777.0, 375431.0, 36614.8169259152, 41993.0, 42776.14447711091, 43733.56266437422, 43809.56190438182, 33211.667883321825, 38626.0, 38692.6130738689, 38912.80543597264, 39340.0, 33847.0, 35067.82466087653, 35219.0, 35405.29189416249, 39305.41041884317, 37560.24879502449, 37989.81005094957, 38051.42922856104, 38161.80919095387, 38412.0, 37904.43143352797, 38206.0, 38238.6176138235, 38349.2330153401, 39676.404853927794, 36894.63105368912, 37729.62270377261, 37888.62111378851, 38091.80954095212, 38566.42150367691, 23093.19173828908, 24629.876850615634, 26705.732942670325, 27051.1884643461, 27506.587401188597], "unit": "score", "name": "ext.html", "value": 19370.22925109641}, {"lowerIsBetter": false, "replicates": [319.2481705583351, 330.86103836388713, 366.18158415940377, 367.43231707012654, 373.02640109314666, 13998.30008499576, 15045.699086018272, 18497.815021849776, 19021.619567608657, 20321.491962700922, 19355.806441935612, 19603.41189764306, 19701.0, 19708.014599270016, 19845.503862403446, 4568.428946381702, 5777.306723193223, 5779.624324418899, 5791.884162316751, 5793.217915581406, 4068.9186216275657, 4254.744715317091, 5392.0, 6078.422549857779, 6312.242530896299, 6081.422264884829, 6231.439170474657, 6278.37216278373, 6279.874402511947, 6281.685915704196, 6205.379462053781, 6244.6253224806205, 6244.750209991595, 6260.718267677943, 6278.277998030239, 4157.0023194433425, 5234.26720259164, 5379.220013098079, 5437.293151890229, 5442.0, 18803.811961880343, 21052.368428947157, 22781.202657906895, 24300.78496075189, 24487.0, 2226.832987525942, 2281.920132795344, 2445.4864478459544, 2871.0812539987214, 2906.346072133774, 11366.37484938328, 11697.824532632018, 14812.629684257872, 14923.776143357858, 15066.924665376713, 1686.401327528734, 1691.4587332053748, 1745.642143360608, 1779.0837718574944, 1789.3021721528614, 72079.0, 89854.5507272466, 92512.0, 93229.53385233098, 95046.52476737641, 10362.171026318027, 10616.734581635366, 10769.192310576738, 10786.029257366874, 10853.565857365775, 12745.17156384832, 12804.935975320064, 12937.964962802953, 12948.935255323662, 12960.675983100498, 8126.959365203136, 8306.003279606486, 8351.665933362598, 8446.155384461505, 8457.577121143919, 7388.224236455202, 7909.694900341494, 8471.110533394029, 8513.489190648581, 8536.701215457553, 4000.8199631016673, 4273.525633656383, 4349.826006959686, 4393.165298593257, 4394.648428125743, 1679.4709666455028, 1778.1109445277361, 1817.9909100454413, 1826.9908650456662, 1935.0614951748391, 408.00446909540625, 409.78076728949867, 410.0896010855895, 424.32744100600894, 838.5597561280255, 11305.321680699184, 11554.133439991867, 11601.593944211912, 11696.70758231051, 11735.295882247092, 451.0527891427975, 461.6491466485495, 467.5698357511098, 474.64662161826584, 487.2934245344265, 6022.427869352405, 6180.47465965389, 6181.0, 6192.783252586228, 6208.72060757267, 590885.0, 622667.0, 625401.0, 642033.0, 662503.0, 113473.43263283631, 115207.0, 115501.422492887, 116573.0, 116822.0, 489.5887454538205, 496.12434053894907, 498.26505903792344, 499.88752530681035, 500.56200824278756, 10854.860239674721, 10956.34261944286, 10976.396298203676, 10998.890011099787, 11053.778924421627, 32445.0, 47949.760251198524, 49148.0, 49362.75318623384, 50224.497755021985, 67738.0, 67830.66084669743, 68100.0, 68434.3156568428, 68817.0, 7516.098068231847, 7703.191164927826, 7720.53676779395, 7742.883856742266, 7749.147593764794, 10487.318324308895, 10497.47512624381, 10670.35977841332, 11749.765004699688, 11924.224925379822, 9896.059874311928, 9979.45113018791, 10024.899751002396, 10110.0, 10156.644517441853, 10000.0, 10025.248106391904, 10196.980301970041, 10569.0, 10704.732381690521, 9840.852387214341, 10182.745431364276, 10451.372917624967, 10454.215933804842, 10494.737631558966, 6836.453083753188, 7121.540084282606, 7465.552066876005, 7553.093628764584, 7639.85402189676, 8310.626021829154, 8764.553848615162, 9813.067758562926, 10023.949880250551, 10334.483275836328], "unit": "score", "name": "jquery.html", "value": 8195.210719384997}, {"lowerIsBetter": false, "replicates": [1461.232852752305, 1535.523987563855, 1748.484197161837, 1876.999999999999, 1884.4911873794085, 7233.638318084095, 7325.6703448344815, 7812.0, 8006.959965200181, 8637.568121593926, 8342.0, 8453.196946290109, 8481.067082620923, 8553.61508732107, 8607.526586037766, 2425.1027119965593, 2459.077845807822, 2461.20010996426, 2467.037855236459, 2467.370820440785, 2420.4311986683115, 2454.1901172612993, 2458.1273647855023, 2459.311392810016, 2461.1386014894824, 2427.4949531290627, 2441.6825812644333, 2463.8398504097268, 2473.1467643662995, 2476.7275599684112, 2436.5614189445805, 2473.0478765675166, 2478.529079474894, 2479.429731161834, 2485.291691867809, 2435.476372579904, 2442.5481285962155, 2468.7160976487753, 2471.5551200783852, 2489.55188066148, 8699.826003479959, 8817.867731984026, 8875.0, 8877.955610221907, 8890.4665720057, 4903.313536104948, 5324.1215199492035, 5388.973055134738, 5410.97294513525, 5505.449455054502, 3616.6202548732267, 3694.9838794331504, 3717.2937141942944, 3719.977006323256, 3763.379042457991, 1046.487221261584, 1068.1988508618535, 1074.930129541585, 1080.3140006096107, 1103.0, 11899.988500977428, 11995.700107497383, 12018.639440816789, 12018.879811201863, 12045.217060891015, 3993.2213218422708, 4918.409790825124, 4930.630202734809, 4949.802007919643, 4955.132851751001, 8390.874136887951, 10189.337693049929, 10203.28576999603, 10244.53899574521, 10269.897301027044, 5365.597580181502, 5421.756020979065, 5437.592180586393, 5445.646033007842, 5495.697736624524, 4450.577195166454, 4586.174488592019, 4854.68444551103, 4991.800327986913, 4995.600351971833, 3916.706247031484, 3961.425593288957, 3966.2265858157957, 4000.5199376075057, 4013.5986401360215, 1310.8951283897457, 1325.8607846176205, 1326.6882282663566, 1330.5210124355224, 1332.060897067565, 1054.414799786126, 1095.4686976816238, 1321.73565286943, 1360.8366995960548, 1364.0792465086226, 7991.360691144694, 8081.191880811872, 8091.231333023354, 8124.878126828103, 8142.470739402039, 498.2799854210703, 503.979840806371, 506.0056988018561, 1245.371087600774, 1316.6379245707508, 6229.906551401733, 6284.057391391237, 6335.11308416822, 6353.650549219745, 6355.618662880242, 8975.28197744179, 9428.10433008863, 9991.100800927807, 10463.84304235437, 10808.675739727822, 8113.269805717514, 10312.639057632947, 10542.156627469783, 10666.36001839892, 10687.83968240477, 8065.9596702016115, 8274.338052955749, 8334.999800024036, 8350.08149103598, 8361.414700970874, 7811.375089992901, 7854.764357069297, 8023.59882005909, 8037.7588672339925, 8050.315723163597, 7929.960350198212, 9133.45199288045, 9465.290103242147, 9471.10024547667, 9555.331126821056, 7672.693092276247, 9175.357724959189, 9513.904860951301, 9705.854412183964, 9813.460259685786, 5432.782688692566, 5994.250718660168, 7102.218755936739, 7419.99660091783, 7444.478886477895, 8142.8778568322705, 8199.467034642728, 8205.671773129008, 8214.63034163476, 8265.049519305116, 6544.312847150981, 7641.541507509567, 7681.039870016248, 7812.414068944966, 7827.84344313122, 7433.665485053294, 7442.106947166375, 7518.774436766906, 7602.771916842504, 7668.463207575416, 7783.104942931409, 7817.983662123887, 7837.725679601414, 7863.882041769492, 7873.488223265469, 7072.752453664097, 7087.291270872872, 7087.751928682677, 7132.643367831484, 7139.571625702474, 7158.463115266271, 7171.49799514029, 7177.497575169897, 7188.388986936169, 7236.89144662841], "unit": "score", "name": "mootools.html", "value": 4856.534681127713}, {"lowerIsBetter": false, "replicates": [327.3975884372754, 331.9717823984961, 333.62300600321635, 337.6117464915348, 341.79663100455235, 6596.868062638744, 6711.5301928865, 6778.661066946657, 6781.186257649083, 6855.383015528601, 6501.447376972963, 6690.966545167267, 6722.630255335955, 6723.092382528357, 6729.899051514231, 4897.902041959159, 4972.975135124319, 5000.749812546864, 5009.0, 5028.647994640377, 4907.411110666725, 5007.824726134586, 5017.297578339036, 5018.949810501903, 5045.1675473547, 4976.950230497685, 4990.176620857555, 5007.874803129933, 5015.398152221738, 5022.321986531808, 4998.700077995314, 4999.725015124167, 5010.248462730583, 5018.64869459138, 5023.070731914608, 3419.9316013679836, 4044.69664775143, 4171.645410140141, 4303.462067241595, 4315.956840431587, 5201.8959620807755, 6405.647689377082, 6437.227532696106, 6445.548811583191, 6446.709898054599, 5304.0, 5426.5077103796375, 5932.436418540232, 5934.139549765303, 5935.643861368331, 6966.965165174192, 7225.277472252786, 7236.746713864989, 7251.492395532315, 7252.782416527512, 4801.135795556798, 4801.255805350176, 4803.423589169287, 4810.302506136625, 4814.470408255089, 7626.42801789868, 7647.235276472308, 7673.386129109658, 7689.577073260968, 7693.615319234016, 4724.314974328703, 4865.148598995162, 4884.169691152512, 4887.902241955212, 4900.583450406684, 4178.895527611834, 4948.876278093005, 5006.874828129253, 5007.273945277914, 5011.198208286657, 5924.081767326072, 5926.466618004314, 5928.229330187134, 5932.555058370639, 5942.970285148546, 7235.855282894313, 7261.673224704795, 7282.453815963824, 7290.8177295566975, 7311.451641126937, 1688.5272123805355, 1710.8289171082793, 1741.3208848549075, 1743.7820272465942, 1745.5723347779876, 1120.8598925134359, 1126.594426006637, 1133.8696049954196, 1138.538891748843, 1139.9829002564968, 6830.93169068303, 6831.11195544576, 6831.316868313228, 6836.658167091626, 6844.486663500257, 7485.588292643848, 7489.213632568501, 7491.700331986768, 7506.3244308012545, 7514.211007844207, 6735.393814556714, 6808.2510923798345, 6845.623490708059, 6874.553154044971, 6993.47548933832, 3106.285554322473, 3969.622885825842, 3992.4610177626228, 4053.0475338296064, 4075.7554546726697, 7786.961065194638, 7839.412044096602, 7966.442349035628, 7998.480098793676, 8001.039875215011, 7908.881366779503, 7917.376937727752, 7923.12845586985, 7925.088614809255, 7926.0, 7810.804729881685, 7913.683452661944, 7950.840983180304, 7969.681212751541, 7992.5204487730925, 7627.618619068913, 7632.274933881273, 7632.5038872473115, 7642.204082040605, 7651.617419129133, 7299.160596531467, 7451.552906825608, 7465.813354666177, 7495.0, 7507.136679281953, 7970.760877173462, 7977.082635496992, 7985.800354991172, 7985.920140798517, 7993.240642138988, 4711.717296962193, 4756.381670382828, 4768.237082066853, 4770.642201834946, 4783.976080119716, 7304.269573042653, 7602.50583712057, 7607.657655405631, 7624.5425274483705, 7664.923350766421, 7274.16347120088, 7283.963580182065, 7292.307230813064, 7310.305520975498, 7317.231690672403, 5877.0, 7252.347288743827, 7270.636468176675, 7271.563706177646, 7279.59962202084, 6320.336364681642, 6450.387213214737, 7110.822229444305, 7123.715051397886, 7147.1780745214965, 7295.270472952662, 7300.16048154469, 7313.634318284171, 7334.926650733424, 7340.302671246223, 6937.375636192767, 7132.0, 7133.500654954103, 7151.749688760869, 7173.0], "unit": "score", "name": "prototype.html", "value": 5324.350168398997}, {"lowerIsBetter": false, "replicates": [651.2347991110444, 665.1120753793685, 673.6699017481433, 709.5671640299413, 725.0243087586327, 14490.565283041513, 14746.262686865653, 14796.964212505129, 14847.480338188165, 17001.82998170018, 15546.922265388657, 15618.297176627051, 15618.453354132607, 15638.0, 15665.138417387068, 699.6606645776794, 854.6325080215505, 866.6490071521013, 869.9173578510031, 871.9389642725012, 704.1655638068879, 845.1801752300258, 866.7789713623017, 871.2811930157613, 872.110447343709, 903.5437104262338, 903.661127077346, 907.7004588485817, 909.3725329522641, 910.4946754551221, 886.2245535156737, 901.4005686218657, 903.4624398482893, 907.1790030022839, 911.4303560274828, 659.9935098974103, 665.3811954881958, 668.759246671198, 670.6814263224978, 672.8385187554951, 15154.0, 15157.469488567958, 15228.162451065187, 15249.542513724606, 15252.23738813066, 12555.560555380518, 12624.495020199181, 12624.55814046504, 12763.978881689443, 13169.20984740909, 9018.458892466473, 9744.658936937172, 10283.640072597424, 11034.834477482844, 11412.657620271406, 3544.663256990582, 3545.574531056264, 3552.573691157052, 3555.0, 3602.189507360849, 55034.44965550333, 58230.41769582292, 81080.59459702663, 81417.59291203566, 84515.0, 9324.533773311307, 9325.533723313807, 9486.715398538056, 9490.905090949002, 9690.515474226402, 20373.59252814965, 20521.66609170399, 20555.075021623765, 20600.27899023527, 20719.689204661943, 5587.0, 7452.85094298111, 7646.0, 7771.145174030852, 7937.920620793718, 3481.860725570949, 4137.848676943306, 4165.8958526037095, 4193.832246710159, 4289.656827453859, 2873.6838947715733, 3453.8791142309897, 3535.575730912307, 3553.058439513531, 3615.475756015363, 658.4173006888938, 664.2062735031687, 666.6033709942576, 686.9141357330334, 688.727952458786, 479.7169669894709, 583.375787906944, 622.6544267931251, 634.4828964394004, 635.6345101566618, 8245.492613412885, 8766.824663506693, 9263.980962094165, 9314.767130821783, 9316.767080823034, 512.6693282832553, 535.5602058931493, 551.4595696217649, 603.6016229288648, 628.3841835001724, 2915.897943572007, 3808.695304375699, 3884.188496215982, 3986.2893232601527, 4058.8579399721457, 80603.5969820159, 82741.3451730962, 82791.17208827834, 83374.58312708519, 83410.58294708487, 71806.0, 72277.0, 72319.63840180871, 72915.0, 73715.26284737191, 63680.36319636837, 63845.0, 64253.357466425674, 64529.0, 64682.67658661676, 8031.759047228593, 8160.632771525415, 8176.918230817853, 8224.671013159646, 8268.04021593789, 37197.698080567054, 37907.62092379041, 38096.0, 39243.60756392399, 43587.9103022427, 55945.16082258851, 58512.12231816611, 59230.0, 59602.70198648979, 60005.39994600173, 9834.164096051916, 9834.557444914853, 9864.901350986398, 9895.554700038372, 9911.157551608194, 10727.141828653845, 10787.0, 11617.941910290732, 12004.579839705917, 12765.93617031946, 9302.720918372459, 11620.489336386216, 11659.88340116588, 11813.881861181622, 11927.926486616247, 11704.122190835551, 11705.707357316136, 11785.528578857093, 11911.0, 12037.699057523281, 11151.168945302566, 11325.0, 11384.43077846121, 11425.828612570984, 11676.94161529187, 9162.348101329106, 9526.333156678966, 9618.230541556799, 9649.807003860024, 9693.224542036762, 9507.239420846454, 9825.852612210965, 9872.0, 9887.851682224917, 9905.702828915144], "unit": "score", "name": "yui.html", "value": 6700.546315734238}], "name": "dromaeo_css", "value": 7323.225570435252}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 114.0, 114.0, 114.0, 127.0, 123.0, 165.0, 126.0, 115.0], "unit": "score", "name": "ai-astar", "value": 122.0}, {"lowerIsBetter": true, "replicates": [158.0, 159.0, 186.0, 151.0, 123.0, 141.0, 133.0, 190.0, 174.0, 108.0], "unit": "score", "name": "audio-beat-detection", "value": 152.3}, {"lowerIsBetter": true, "replicates": [193.0, 192.0, 195.0, 217.0, 221.0, 193.0, 198.0, 192.0, 228.0, 274.0], "unit": "score", "name": "audio-dft", "value": 210.3}, {"lowerIsBetter": true, "replicates": [65.0, 72.0, 77.0, 112.0, 58.0, 58.0, 60.0, 59.0, 111.0, 58.0], "unit": "score", "name": "audio-fft", "value": 73.0}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 118.0, 79.0, 80.0, 88.0, 113.0, 81.0, 82.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 92.3}, {"lowerIsBetter": true, "replicates": [88.0, 92.0, 74.0, 124.0, 133.0, 94.0, 88.0, 129.0, 87.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 100.0}, {"lowerIsBetter": true, "replicates": [105.0, 150.0, 151.0, 112.0, 95.0, 95.0, 97.0, 95.0, 98.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 109.4}, {"lowerIsBetter": true, "replicates": [94.0, 125.0, 149.0, 95.0, 107.0, 98.0, 120.0, 123.0, 96.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 109.8}, {"lowerIsBetter": true, "replicates": [49.0, 57.0, 83.0, 83.0, 56.0, 56.0, 53.0, 72.0, 65.0, 47.0], "unit": "score", "name": "json-parse-financial", "value": 62.1}, {"lowerIsBetter": true, "replicates": [68.0, 86.0, 84.0, 74.0, 72.0, 74.0, 97.0, 98.0, 83.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 80.0}, {"lowerIsBetter": true, "replicates": [95.0, 86.0, 87.0, 82.0, 86.0, 85.0, 85.0, 83.0, 87.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [135.0, 133.0, 136.0, 148.0, 138.0, 133.0, 115.0, 122.0, 132.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.7}, {"lowerIsBetter": true, "replicates": [145.0, 142.0, 145.0, 141.0, 142.0, 143.0, 139.0, 138.0, 142.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 61.0, 55.0, 74.0, 97.0, 93.0, 97.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.1}], "name": "kraken", "value": 1545.3}]} 04:52:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1545.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7323.22"}}} 04:52:39 INFO - Return code: 0 04:52:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:52:39 ERROR - # TBPL SUCCESS # 04:52:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:52:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:52:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:52:39 INFO - 2016-02-06 04:52:39.222 screenresolution[1698:11291] starting screenresolution argv=screenresolution get 04:52:39 INFO - 2016-02-06 04:52:39.225 screenresolution[1698:11291] Display 0: 1600x1200x32@60 04:52:39 INFO - 2016-02-06 04:52:39.230 screenresolution[1699:11294] starting screenresolution argv=screenresolution list 04:52:39 INFO - Available Modes on Display 0 04:52:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:52:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:52:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:52:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:52:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:52:39 INFO - Intel Iris: 04:52:39 INFO - Chipset Model: Intel Iris 04:52:39 INFO - Type: GPU 04:52:39 INFO - Bus: Built-In 04:52:39 INFO - VRAM (Dynamic, Max): 1536 MB 04:52:39 INFO - Vendor: Intel (0x8086) 04:52:39 INFO - Device ID: 0x0a2e 04:52:39 INFO - Revision ID: 0x0009 04:52:39 INFO - Displays: 04:52:39 INFO - Display: 04:52:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:52:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:52:39 INFO - Display Serial Number: 1600x1200 60 04:52:39 INFO - Main Display: Yes 04:52:39 INFO - Mirror: Off 04:52:39 INFO - Online: Yes 04:52:39 INFO - Rotation: Supported 04:52:39 INFO - Return code: 0 04:52:39 INFO - Running post-action listener: _resource_record_post_action 04:52:39 INFO - Running post-run listener: _resource_record_post_run 04:52:40 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 34057728; Write bytes: 712030720; Read time: 357; Write time: 1936 04:52:40 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 245760; Write bytes: 406288384; Read time: 5; Write time: 691 04:52:40 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 32267776; Write bytes: 304894464; Read time: 337; Write time: 1244 04:52:40 INFO - Running post-run listener: _upload_blobber_files 04:52:40 INFO - Blob upload gear active. 04:52:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:40 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 04:52:40 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'] 04:52:40 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 04:52:40 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:52:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:52:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:42 INFO - (blobuploader) - INFO - Done attempting. 04:52:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:52:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:43 INFO - (blobuploader) - INFO - Done attempting. 04:52:43 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:43 INFO - Return code: 0 04:52:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc9ff6583a52a94acc2e8fa19cbe0ba7739d0bf760588028aa1239e6517326905d02e5b49227d030f8810fdbc8020f9a609298b8e5a1a8294edddb222c8c281d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/517ce3f7efa50a333d294baab0a5416719f29e055b3535edd1b5a5dc2a68416bf1d34346978062791b23d41a70d7a1b32b1551fd7ed793d8bb042c367a3bae3d"} 04:52:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:43 INFO - Contents: 04:52:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc9ff6583a52a94acc2e8fa19cbe0ba7739d0bf760588028aa1239e6517326905d02e5b49227d030f8810fdbc8020f9a609298b8e5a1a8294edddb222c8c281d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/517ce3f7efa50a333d294baab0a5416719f29e055b3535edd1b5a5dc2a68416bf1d34346978062791b23d41a70d7a1b32b1551fd7ed793d8bb042c367a3bae3d"} 04:52:43 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:43 INFO - Copying logs to upload dir... 04:52:43 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.278966 ========= master_lag: 2.64 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-02-06 04:52:46.045932) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 04:52:46.049766) ========= 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.yUNaPTEP6B/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.Es7X9hk15m/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/cc9ff6583a52a94acc2e8fa19cbe0ba7739d0bf760588028aa1239e6517326905d02e5b49227d030f8810fdbc8020f9a609298b8e5a1a8294edddb222c8c281d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/517ce3f7efa50a333d294baab0a5416719f29e055b3535edd1b5a5dc2a68416bf1d34346978062791b23d41a70d7a1b32b1551fd7ed793d8bb042c367a3bae3d"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010958 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc9ff6583a52a94acc2e8fa19cbe0ba7739d0bf760588028aa1239e6517326905d02e5b49227d030f8810fdbc8020f9a609298b8e5a1a8294edddb222c8c281d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/517ce3f7efa50a333d294baab0a5416719f29e055b3535edd1b5a5dc2a68416bf1d34346978062791b23d41a70d7a1b32b1551fd7ed793d8bb042c367a3bae3d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 04:52:46.081285) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:52:46.081586) ========= 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.yUNaPTEP6B/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.Es7X9hk15m/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.005083 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:52:46.132873) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 04:52:46.133308) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 04:52:46.133650) ========= ========= Total master_lag: 3.06 =========