builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0077 starttime: 1455669399.41 results: success (0) buildid: 20160216143851 builduid: 98c3385bdfd5485b98a4db5381439f4e revision: b8003b4c63c378bd43065f6faf540b5288d9f617 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:39.412194) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:39.412702) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:39.413038) ========= 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.MrKBKjFLks/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.1SuNbQVHht/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.005678 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:39.436712) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:39.437271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:39.453147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:39.453449) ========= 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.MrKBKjFLks/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.1SuNbQVHht/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.005569 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:39.502239) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:39.502579) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:39.502991) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:39.503320) ========= 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.MrKBKjFLks/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.1SuNbQVHht/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-16 16:36:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 152M=0s 2016-02-16 16:36:39 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177247 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:39.698146) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:39.698503) ========= 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.MrKBKjFLks/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.1SuNbQVHht/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.020170 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:39.747166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-02-16 16:36:39.747541) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b8003b4c63c378bd43065f6faf540b5288d9f617 --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 b8003b4c63c378bd43065f6faf540b5288d9f617 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MrKBKjFLks/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.1SuNbQVHht/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-16 16:36:39,821 truncating revision to first 12 chars 2016-02-16 16:36:39,821 Setting DEBUG logging. 2016-02-16 16:36:39,822 attempt 1/10 2016-02-16 16:36:39,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b8003b4c63c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-16 16:36:40,535 unpacking tar archive at: fx-team-b8003b4c63c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.963668 ========= master_lag: 2.44 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-02-16 16:36:43.147414) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:43.147828) ========= echo b8003b4c63c378bd43065f6faf540b5288d9f617 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b8003b4c63c378bd43065f6faf540b5288d9f617'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MrKBKjFLks/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.1SuNbQVHht/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 b8003b4c63c378bd43065f6faf540b5288d9f617 program finished with exit code 0 elapsedTime=0.005234 script_repo_revision: 'b8003b4c63c378bd43065f6faf540b5288d9f617' ========= master_lag: 0.03 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:43.186947) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:43.187313) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 16:36:43.206201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-02-16 16:36:43.206550) ========= /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.MrKBKjFLks/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.1SuNbQVHht/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 16:36:43 INFO - MultiFileLogger online at 20160216 16:36:43 in /builds/slave/test 16:36:43 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 16:36:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:36:43 INFO - {'append_to_log': False, 16:36:43 INFO - 'base_work_dir': '/builds/slave/test', 16:36:43 INFO - 'blob_upload_branch': 'Fx-Team', 16:36:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:36:43 INFO - 'branch': 'Fx-Team', 16:36:43 INFO - 'buildbot_json_path': 'buildprops.json', 16:36:43 INFO - 'config_files': ('talos/mac_config.py',), 16:36:43 INFO - 'default_actions': ('clobber', 16:36:43 INFO - 'read-buildbot-config', 16:36:43 INFO - 'download-and-extract', 16:36:43 INFO - 'populate-webroot', 16:36:43 INFO - 'create-virtualenv', 16:36:43 INFO - 'install', 16:36:43 INFO - 'run-tests'), 16:36:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:36:43 INFO - 'download_minidump_stackwalk': True, 16:36:43 INFO - 'download_symbols': 'ondemand', 16:36:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:36:43 INFO - 'tooltool.py': '/tools/tooltool.py', 16:36:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:36:43 INFO - '/tools/misc-python/virtualenv.py')}, 16:36:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:36:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:36:43 INFO - 'installer_path': 'installer.exe', 16:36:43 INFO - 'log_level': 'info', 16:36:43 INFO - 'log_name': 'talos', 16:36:43 INFO - 'log_to_console': True, 16:36:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:36:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:36:43 INFO - 'opt_config_files': (), 16:36:43 INFO - 'pip_index': False, 16:36:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:36:43 INFO - 'cmd': ('bash', 16:36:43 INFO - '-c', 16:36:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:36:43 INFO - 'enabled': True, 16:36:43 INFO - 'halt_on_failure': False, 16:36:43 INFO - 'name': 'check_screen_resolution'},), 16:36:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:36:43 INFO - 'cmd': ('bash', 16:36:43 INFO - '-c', 16:36:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:36:43 INFO - 'enabled': True, 16:36:43 INFO - 'halt_on_failure': False, 16:36:43 INFO - 'name': 'check_screen_resolution'},), 16:36:43 INFO - 'run_cmd_checks_enabled': True, 16:36:43 INFO - 'sps_profile': False, 16:36:43 INFO - 'sps_profile_interval': 0, 16:36:43 INFO - 'suite': 'dromaeojs-e10s', 16:36:43 INFO - 'system_bits': '32', 16:36:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:36:43 INFO - 'title': 't-yosemite-r7-0077', 16:36:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:36:43 INFO - 'use_talos_json': True, 16:36:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:36:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:36:43 INFO - 'work_dir': 'build'} 16:36:43 INFO - ##### 16:36:43 INFO - ##### Running clobber step. 16:36:43 INFO - ##### 16:36:43 INFO - Running pre-action listener: _resource_record_pre_action 16:36:43 INFO - Running main action method: clobber 16:36:43 INFO - rmtree: /builds/slave/test/build 16:36:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:36:44 INFO - Running post-action listener: _resource_record_post_action 16:36:44 INFO - ##### 16:36:44 INFO - ##### Running read-buildbot-config step. 16:36:44 INFO - ##### 16:36:44 INFO - Running pre-action listener: _resource_record_pre_action 16:36:44 INFO - Running main action method: read_buildbot_config 16:36:44 INFO - Using buildbot properties: 16:36:44 INFO - { 16:36:44 INFO - "project": "", 16:36:44 INFO - "product": "firefox", 16:36:44 INFO - "script_repo_revision": "production", 16:36:44 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:36:44 INFO - "repository": "", 16:36:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:36:44 INFO - "buildid": "20160216143851", 16:36:44 INFO - "pgo_build": "False", 16:36:44 INFO - "basedir": "/builds/slave/test", 16:36:44 INFO - "buildnumber": 403, 16:36:44 INFO - "slavename": "t-yosemite-r7-0077", 16:36:44 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:36:44 INFO - "platform": "yosemite_r7", 16:36:44 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:36:44 INFO - "branch": "fx-team", 16:36:44 INFO - "repo_path": "integration/fx-team", 16:36:44 INFO - "revision": "b8003b4c63c378bd43065f6faf540b5288d9f617", 16:36:44 INFO - "stage_platform": "macosx64", 16:36:44 INFO - "builduid": "98c3385bdfd5485b98a4db5381439f4e", 16:36:44 INFO - "slavebuilddir": "test" 16:36:44 INFO - } 16:36:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 16:36:44 INFO - Running post-action listener: _resource_record_post_action 16:36:44 INFO - ##### 16:36:44 INFO - ##### Running download-and-extract step. 16:36:44 INFO - ##### 16:36:44 INFO - Running pre-action listener: _resource_record_pre_action 16:36:44 INFO - Running main action method: download_and_extract 16:36:44 INFO - mkdir: /builds/slave/test/build/tests 16:36:44 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')]} 16:36:44 INFO - https://queue.taskcluster.net/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:36:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/test_packages.json 16:36:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/test_packages.json 16:36:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:36:45 INFO - Downloaded 1277 bytes. 16:36:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:36:45 INFO - Using the following test package requirements: 16:36:45 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:36:45 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:45 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 16:36:45 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:45 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 16:36:45 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:45 INFO - u'jsshell-mac.zip'], 16:36:45 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:45 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 16:36:45 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:36:45 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:45 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 16:36:45 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:45 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 16:36:45 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:45 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 16:36:45 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:36:45 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:45 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 16:36:45 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:45 INFO - https://queue.taskcluster.net/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:36:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:36:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:36:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:36:46 INFO - Downloaded 17803649 bytes. 16:36:46 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'] 16:36:46 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 16:36:49 INFO - Return code: 0 16:36:49 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 16:36:49 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')]} 16:36:49 INFO - https://queue.taskcluster.net/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:36:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:36:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:36:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:36:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:36:50 INFO - Downloaded 17803649 bytes. 16:36:50 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'] 16:36:50 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 16:36:54 INFO - Return code: 0 16:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:54 INFO - https://queue.taskcluster.net/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:36:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:36:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:36:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:36:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:36:55 INFO - Downloaded 10707071 bytes. 16:36: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'] 16:36: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 16:36:55 INFO - Return code: 0 16:36: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')]} 16:36:55 INFO - https://queue.taskcluster.net/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:36:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:36:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:36:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 16:36:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 16:36:58 INFO - Downloaded 111174916 bytes. 16:36:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:36:58 INFO - mkdir: /builds/slave/test/properties 16:36:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:36:58 INFO - Writing to file /builds/slave/test/properties/build_url 16:36:58 INFO - Contents: 16:36:58 INFO - build_url:https://queue.taskcluster.net/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:36:59 INFO - Running post-action listener: _resource_record_post_action 16:36:59 INFO - Running post-action listener: set_extra_try_arguments 16:36:59 INFO - ##### 16:36:59 INFO - ##### Running populate-webroot step. 16:36:59 INFO - ##### 16:36:59 INFO - Running pre-action listener: _resource_record_pre_action 16:36:59 INFO - Running main action method: populate_webroot 16:36:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:36:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:36:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:36:59 INFO - '--tppagecycles', 16:36:59 INFO - '7'], 16:36:59 INFO - 'tests': ['tsvgm']}}, 16:36:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:36:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:36:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:36:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:36:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:36:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:36:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:59 INFO - 'talos_options': ['--e10s'], 16:36:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:59 INFO - 'tests': ['damp', 'tps']}, 16:36:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:59 INFO - 'talos_options': ['--e10s'], 16:36:59 INFO - 'tests': ['damp', 'tps']}, 16:36:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:36:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:36:59 INFO - 'other': {'tests': ['a11yr', 16:36:59 INFO - 'ts_paint', 16:36:59 INFO - 'tpaint', 16:36:59 INFO - 'sessionrestore', 16:36:59 INFO - 'sessionrestore_no_auto_restore']}, 16:36:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:36:59 INFO - 'tests': ['a11yr', 16:36:59 INFO - 'ts_paint', 16:36:59 INFO - 'tpaint', 16:36:59 INFO - 'sessionrestore', 16:36:59 INFO - 'sessionrestore_no_auto_restore']}, 16:36:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:36:59 INFO - 'tests': ['a11yr', 16:36:59 INFO - 'ts_paint', 16:36:59 INFO - 'tpaint', 16:36:59 INFO - 'sessionrestore', 16:36:59 INFO - 'sessionrestore_no_auto_restore']}, 16:36:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:36:59 INFO - 'tests': ['a11yr', 16:36:59 INFO - 'ts_paint', 16:36:59 INFO - 'tpaint', 16:36:59 INFO - 'sessionrestore', 16:36:59 INFO - 'sessionrestore_no_auto_restore']}, 16:36:59 INFO - 'other_l64': {'tests': ['a11yr', 16:36:59 INFO - 'ts_paint', 16:36:59 INFO - 'tpaint', 16:36:59 INFO - 'sessionrestore', 16:36:59 INFO - 'sessionrestore_no_auto_restore']}, 16:36:59 INFO - 'other_nol64': {'tests': ['a11yr', 16:36:59 INFO - 'ts_paint', 16:36:59 INFO - 'tpaint', 16:36:59 INFO - 'sessionrestore', 16:36:59 INFO - 'sessionrestore_no_auto_restore']}, 16:36:59 INFO - 'svgr': {'tests': ['tsvgx', 16:36:59 INFO - 'tsvgr_opacity', 16:36:59 INFO - 'tart', 16:36:59 INFO - 'tscrollx', 16:36:59 INFO - 'cart']}, 16:36:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:36:59 INFO - 'tests': ['tsvgx', 16:36:59 INFO - 'tsvgr_opacity', 16:36:59 INFO - 'tart', 16:36:59 INFO - 'tscrollx', 16:36:59 INFO - 'cart']}, 16:36:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:59 INFO - 'tests': ['tp5o']}, 16:36:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:59 INFO - 'talos_options': ['--e10s'], 16:36:59 INFO - 'tests': ['tp5o']}, 16:36:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:59 INFO - 'talos_options': ['--xperf_path', 16:36:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:59 INFO - 'tests': ['tp5n']}, 16:36:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:59 INFO - 'talos_options': ['--e10s', 16:36:59 INFO - '--xperf_path', 16:36:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:59 INFO - 'tests': ['tp5n']}}, 16:36:59 INFO - 'talos.zip': {'path': '', 16:36:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:36:59 INFO - Running post-action listener: _resource_record_post_action 16:36:59 INFO - ##### 16:36:59 INFO - ##### Running create-virtualenv step. 16:36:59 INFO - ##### 16:36:59 INFO - Running pre-action listener: _resource_record_pre_action 16:36:59 INFO - Running main action method: create_virtualenv 16:36:59 INFO - Creating virtualenv /builds/slave/test/build/venv 16:36:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:36:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:36:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:36:59 INFO - Using real prefix '/tools/python27' 16:36:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:36:59 INFO - Installing distribute.............................................................................................................................................................................................done. 16:37:02 INFO - Installing pip.................done. 16:37:02 INFO - Return code: 0 16:37:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:37:02 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')]} 16:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:02 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')]} 16:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:02 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 0x109a36a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a3d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd2599210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098dad30>, '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 0x1096fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098d1b20>, '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.MrKBKjFLks/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.1SuNbQVHht/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 16:37:02 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 16:37:02 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 16:37:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MrKBKjFLks/Render', 16:37:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:02 INFO - 'HOME': '/Users/cltbld', 16:37:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:02 INFO - 'LOGNAME': 'cltbld', 16:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:02 INFO - 'MOZ_NO_REMOTE': '1', 16:37:02 INFO - 'NO_EM_RESTART': '1', 16:37:02 INFO - 'PAGER': '/bin/cat', 16:37:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:02 INFO - 'PWD': '/builds/slave/test', 16:37:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:02 INFO - 'SHELL': '/bin/bash', 16:37:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1SuNbQVHht/Listeners', 16:37:02 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:37:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:02 INFO - 'USER': 'cltbld', 16:37:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:02 INFO - 'XPC_FLAGS': '0x0', 16:37:02 INFO - 'XPC_SERVICE_NAME': '0', 16:37:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:37:03 INFO - Cleaning up... 16:37:03 INFO - Return code: 0 16:37:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a36a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a3d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd2599210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098dad30>, '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 0x1096fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098d1b20>, '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.MrKBKjFLks/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.1SuNbQVHht/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 16:37:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:37:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MrKBKjFLks/Render', 16:37:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:03 INFO - 'HOME': '/Users/cltbld', 16:37:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:03 INFO - 'LOGNAME': 'cltbld', 16:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:03 INFO - 'MOZ_NO_REMOTE': '1', 16:37:03 INFO - 'NO_EM_RESTART': '1', 16:37:03 INFO - 'PAGER': '/bin/cat', 16:37:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:03 INFO - 'PWD': '/builds/slave/test', 16:37:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:03 INFO - 'SHELL': '/bin/bash', 16:37:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1SuNbQVHht/Listeners', 16:37:03 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:37:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:03 INFO - 'USER': 'cltbld', 16:37:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:03 INFO - 'XPC_FLAGS': '0x0', 16:37:03 INFO - 'XPC_SERVICE_NAME': '0', 16:37:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:03 INFO - Downloading/unpacking psutil>=0.7.1 16:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:37:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:06 INFO - Installing collected packages: psutil 16:37:06 INFO - Running setup.py install for psutil 16:37:06 INFO - building 'psutil._psutil_osx' extension 16:37:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:37: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 16:37: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 16:37: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 16:37:06 INFO - building 'psutil._psutil_posix' extension 16:37: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 16:37:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:37:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:37:06 INFO - ^ 16:37:06 INFO - 1 warning generated. 16:37: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 16:37:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:06 INFO - Successfully installed psutil 16:37:06 INFO - Cleaning up... 16:37:07 INFO - Return code: 0 16:37:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a36a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a3d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd2599210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098dad30>, '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 0x1096fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098d1b20>, '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.MrKBKjFLks/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.1SuNbQVHht/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 16:37:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:37:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:37:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MrKBKjFLks/Render', 16:37:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:07 INFO - 'HOME': '/Users/cltbld', 16:37:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:07 INFO - 'LOGNAME': 'cltbld', 16:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:07 INFO - 'MOZ_NO_REMOTE': '1', 16:37:07 INFO - 'NO_EM_RESTART': '1', 16:37:07 INFO - 'PAGER': '/bin/cat', 16:37:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:07 INFO - 'PWD': '/builds/slave/test', 16:37:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:07 INFO - 'SHELL': '/bin/bash', 16:37:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1SuNbQVHht/Listeners', 16:37:07 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:37:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:07 INFO - 'USER': 'cltbld', 16:37:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:07 INFO - 'XPC_FLAGS': '0x0', 16:37:07 INFO - 'XPC_SERVICE_NAME': '0', 16:37:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:37: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) 16:37:09 INFO - Installing collected packages: mozsystemmonitor 16:37:09 INFO - Running setup.py install for mozsystemmonitor 16:37:09 INFO - Successfully installed mozsystemmonitor 16:37:09 INFO - Cleaning up... 16:37:09 INFO - Return code: 0 16:37:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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 0x109a36a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a3d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd2599210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098dad30>, '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 0x1096fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098d1b20>, '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.MrKBKjFLks/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.1SuNbQVHht/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 16:37: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 16:37: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 16:37:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MrKBKjFLks/Render', 16:37:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:09 INFO - 'HOME': '/Users/cltbld', 16:37:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:09 INFO - 'LOGNAME': 'cltbld', 16:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:09 INFO - 'MOZ_NO_REMOTE': '1', 16:37:09 INFO - 'NO_EM_RESTART': '1', 16:37:09 INFO - 'PAGER': '/bin/cat', 16:37:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:09 INFO - 'PWD': '/builds/slave/test', 16:37:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:09 INFO - 'SHELL': '/bin/bash', 16:37:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1SuNbQVHht/Listeners', 16:37:09 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:37:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:09 INFO - 'USER': 'cltbld', 16:37:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:09 INFO - 'XPC_FLAGS': '0x0', 16:37:09 INFO - 'XPC_SERVICE_NAME': '0', 16:37:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:10 INFO - Downloading/unpacking blobuploader==1.2.4 16:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:12 INFO - Downloading blobuploader-1.2.4.tar.gz 16:37:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:37:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:37:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:13 INFO - Downloading docopt-0.6.1.tar.gz 16:37:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:37:13 INFO - Installing collected packages: blobuploader, requests, docopt 16:37:13 INFO - Running setup.py install for blobuploader 16:37:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:37:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:37:13 INFO - Running setup.py install for requests 16:37:14 INFO - Running setup.py install for docopt 16:37:14 INFO - Successfully installed blobuploader requests docopt 16:37:14 INFO - Cleaning up... 16:37:14 INFO - Return code: 0 16:37:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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 0x109a36a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a3d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd2599210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098dad30>, '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 0x1096fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098d1b20>, '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.MrKBKjFLks/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.1SuNbQVHht/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 16:37: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 16:37: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 16:37:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MrKBKjFLks/Render', 16:37:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:14 INFO - 'HOME': '/Users/cltbld', 16:37:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:14 INFO - 'LOGNAME': 'cltbld', 16:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:14 INFO - 'MOZ_NO_REMOTE': '1', 16:37:14 INFO - 'NO_EM_RESTART': '1', 16:37:14 INFO - 'PAGER': '/bin/cat', 16:37:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:14 INFO - 'PWD': '/builds/slave/test', 16:37:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:14 INFO - 'SHELL': '/bin/bash', 16:37:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1SuNbQVHht/Listeners', 16:37:14 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:37:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:14 INFO - 'USER': 'cltbld', 16:37:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:14 INFO - 'XPC_FLAGS': '0x0', 16:37:14 INFO - 'XPC_SERVICE_NAME': '0', 16:37:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:14 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-vnacdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:14 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-uD5L9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:15 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-DWsSJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:15 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-EeGDo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:15 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-M_r6Rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:15 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-xVMHIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:15 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-exizZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:15 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-0hzvTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:15 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-QHrA5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:15 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-1IpilQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:15 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-kwSWnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:15 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-8kgmgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:16 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-_hQydy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:16 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-f2SZVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:16 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-BZA_aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:16 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-DcMFZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:16 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-NT9QcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:37:16 INFO - Running setup.py install for manifestparser 16:37:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:37:16 INFO - Running setup.py install for mozcrash 16:37:16 INFO - Running setup.py install for mozdebug 16:37:16 INFO - Running setup.py install for mozdevice 16:37:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:37:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:37:17 INFO - Running setup.py install for mozfile 16:37:17 INFO - Running setup.py install for mozhttpd 16:37:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:37:17 INFO - Running setup.py install for mozinfo 16:37:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:37:17 INFO - Running setup.py install for mozInstall 16:37:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:37:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:37:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:37:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:37:17 INFO - Running setup.py install for mozleak 16:37:17 INFO - Running setup.py install for mozlog 16:37:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:37:18 INFO - Running setup.py install for moznetwork 16:37:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:37:18 INFO - Running setup.py install for mozprocess 16:37:18 INFO - Running setup.py install for mozprofile 16:37:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:37:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:37:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:37:18 INFO - Running setup.py install for mozrunner 16:37:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:37:18 INFO - Running setup.py install for mozscreenshot 16:37:18 INFO - Running setup.py install for moztest 16:37:18 INFO - Running setup.py install for mozversion 16:37:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:37:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:37:19 INFO - Cleaning up... 16:37:19 INFO - Return code: 0 16:37:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:19 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')]} 16:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:19 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')]} 16:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:19 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 0x109a36a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a3d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd2599210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098dad30>, '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 0x1096fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098d1b20>, '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.MrKBKjFLks/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.1SuNbQVHht/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 16:37:19 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 16:37:19 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 16:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MrKBKjFLks/Render', 16:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:19 INFO - 'HOME': '/Users/cltbld', 16:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:19 INFO - 'LOGNAME': 'cltbld', 16:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:19 INFO - 'MOZ_NO_REMOTE': '1', 16:37:19 INFO - 'NO_EM_RESTART': '1', 16:37:19 INFO - 'PAGER': '/bin/cat', 16:37:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:19 INFO - 'PWD': '/builds/slave/test', 16:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:19 INFO - 'SHELL': '/bin/bash', 16:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1SuNbQVHht/Listeners', 16:37:19 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:19 INFO - 'USER': 'cltbld', 16:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:19 INFO - 'XPC_FLAGS': '0x0', 16:37:19 INFO - 'XPC_SERVICE_NAME': '0', 16:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:19 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-z4zA2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37: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)) 16:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:19 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-a1pIg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37: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)) 16:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:19 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-86co9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37: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)) 16:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:19 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-IA8uEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37: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)) 16:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:19 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-F88Ozt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37: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)) 16:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:19 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-dvDnms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:20 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)) 16:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:20 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Vg9Dfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:20 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)) 16:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:20 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-bc5RiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:20 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)) 16:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:20 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-9k7Sw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:20 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)) 16:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:20 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Kt9DEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:20 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)) 16:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:20 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-IMQk0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37: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)) 16:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:20 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-qB1tbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37: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)) 16:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:20 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-IhDssO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37: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)) 16:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:20 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-DK5pfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37: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)) 16:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:20 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-utbBbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37: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)) 16:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:21 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-1s4YYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:21 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)) 16:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:21 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-jDSTEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:21 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)) 16:37:21 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)) 16:37:21 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)) 16:37:21 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)) 16:37:21 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)) 16:37:21 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)) 16:37:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37:21 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 16:37:21 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 16:37:21 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 16:37:21 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 16:37:21 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 16:37:21 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 16:37:23 INFO - Downloading blessings-1.6.tar.gz 16:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:37:23 INFO - Installing collected packages: blessings 16:37:23 INFO - Running setup.py install for blessings 16:37:23 INFO - Successfully installed blessings 16:37:23 INFO - Cleaning up... 16:37:23 INFO - Return code: 0 16:37:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:37:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:24 INFO - Reading from file tmpfile_stdout 16:37:24 INFO - Current package versions: 16:37:24 INFO - blessings == 1.6 16:37:24 INFO - blobuploader == 1.2.4 16:37:24 INFO - docopt == 0.6.1 16:37:24 INFO - manifestparser == 1.1 16:37:24 INFO - mozInstall == 1.12 16:37:24 INFO - mozcrash == 0.16 16:37:24 INFO - mozdebug == 0.1 16:37:24 INFO - mozdevice == 0.48 16:37:24 INFO - mozfile == 1.2 16:37:24 INFO - mozhttpd == 0.7 16:37:24 INFO - mozinfo == 0.9 16:37:24 INFO - mozleak == 0.1 16:37:24 INFO - mozlog == 3.1 16:37:24 INFO - moznetwork == 0.27 16:37:24 INFO - mozprocess == 0.22 16:37:24 INFO - mozprofile == 0.28 16:37:24 INFO - mozrunner == 6.11 16:37:24 INFO - mozscreenshot == 0.1 16:37:24 INFO - mozsystemmonitor == 0.0 16:37:24 INFO - moztest == 0.7 16:37:24 INFO - mozversion == 1.4 16:37:24 INFO - psutil == 3.1.1 16:37:24 INFO - requests == 1.2.3 16:37:24 INFO - wsgiref == 0.1.2 16:37:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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 0x109a36a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a3d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd2599210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098dad30>, '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 0x1096fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098d1b20>, '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.MrKBKjFLks/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.1SuNbQVHht/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 16:37: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 16:37: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 16:37:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MrKBKjFLks/Render', 16:37:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:24 INFO - 'HOME': '/Users/cltbld', 16:37:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:24 INFO - 'LOGNAME': 'cltbld', 16:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:24 INFO - 'MOZ_NO_REMOTE': '1', 16:37:24 INFO - 'NO_EM_RESTART': '1', 16:37:24 INFO - 'PAGER': '/bin/cat', 16:37:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:24 INFO - 'PWD': '/builds/slave/test', 16:37:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:24 INFO - 'SHELL': '/bin/bash', 16:37:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1SuNbQVHht/Listeners', 16:37:24 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:37:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:24 INFO - 'USER': 'cltbld', 16:37:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:24 INFO - 'XPC_FLAGS': '0x0', 16:37:24 INFO - 'XPC_SERVICE_NAME': '0', 16:37:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37: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)) 16:37: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)) 16:37: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)) 16:37: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)) 16:37: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)) 16:37: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)) 16:37: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)) 16:37: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)) 16:37: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)) 16:37: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)) 16:37: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)) 16:37:24 INFO - Cleaning up... 16:37:24 INFO - Return code: 0 16:37:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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 0x109a36a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a3d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd2599210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098dad30>, '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 0x1096fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098d1b20>, '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.MrKBKjFLks/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.1SuNbQVHht/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 16:37: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 16:37: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 16:37:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MrKBKjFLks/Render', 16:37:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:24 INFO - 'HOME': '/Users/cltbld', 16:37:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:24 INFO - 'LOGNAME': 'cltbld', 16:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:24 INFO - 'MOZ_NO_REMOTE': '1', 16:37:24 INFO - 'NO_EM_RESTART': '1', 16:37:24 INFO - 'PAGER': '/bin/cat', 16:37:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:24 INFO - 'PWD': '/builds/slave/test', 16:37:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:24 INFO - 'SHELL': '/bin/bash', 16:37:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1SuNbQVHht/Listeners', 16:37:24 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:37:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:24 INFO - 'USER': 'cltbld', 16:37:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:24 INFO - 'XPC_FLAGS': '0x0', 16:37:24 INFO - 'XPC_SERVICE_NAME': '0', 16:37:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:24 INFO - Downloading/unpacking jsonschema 16:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:37:26 INFO - Downloading/unpacking functools32 (from jsonschema) 16:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:27 INFO - Downloading functools32-3.2.3-2.tar.gz 16:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:37:27 INFO - warning: no files found matching '*.txt' 16:37:27 INFO - no previously-included directories found matching 'build' 16:37:27 INFO - no previously-included directories found matching 'dist' 16:37:27 INFO - no previously-included directories found matching '.git*' 16:37:27 INFO - Installing collected packages: jsonschema, functools32 16:37:27 INFO - Running setup.py install for functools32 16:37:27 INFO - warning: no files found matching '*.txt' 16:37:27 INFO - no previously-included directories found matching 'build' 16:37:27 INFO - no previously-included directories found matching 'dist' 16:37:27 INFO - no previously-included directories found matching '.git*' 16:37:27 INFO - Successfully installed jsonschema functools32 16:37:27 INFO - Cleaning up... 16:37:27 INFO - Return code: 0 16:37:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:37:27 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')]} 16:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:27 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')]} 16:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:27 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 0x109a36a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a3d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd2599210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098dad30>, '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 0x1096fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098d1b20>, '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.MrKBKjFLks/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.1SuNbQVHht/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 16:37:27 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 16:37:27 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 16:37:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MrKBKjFLks/Render', 16:37:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:27 INFO - 'HOME': '/Users/cltbld', 16:37:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:27 INFO - 'LOGNAME': 'cltbld', 16:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:27 INFO - 'MOZ_NO_REMOTE': '1', 16:37:27 INFO - 'NO_EM_RESTART': '1', 16:37:27 INFO - 'PAGER': '/bin/cat', 16:37:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:27 INFO - 'PWD': '/builds/slave/test', 16:37:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:27 INFO - 'SHELL': '/bin/bash', 16:37:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1SuNbQVHht/Listeners', 16:37:27 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:37:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:27 INFO - 'USER': 'cltbld', 16:37:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:27 INFO - 'XPC_FLAGS': '0x0', 16:37:27 INFO - 'XPC_SERVICE_NAME': '0', 16:37:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:28 INFO - Downloading/unpacking flake8 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:37:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:37:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:37:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:31 INFO - no previously-included directories found matching 'docs/_build' 16:37:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:37:31 INFO - Running setup.py install for pep8 16:37:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:31 INFO - no previously-included directories found matching 'docs/_build' 16:37:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:37:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:37:31 INFO - Cleaning up... 16:37:31 INFO - Return code: 0 16:37:31 INFO - Running post-action listener: _resource_record_post_action 16:37:31 INFO - Running post-action listener: _start_resource_monitoring 16:37:31 INFO - Starting resource monitoring. 16:37:31 INFO - ##### 16:37:31 INFO - ##### Running install step. 16:37:31 INFO - ##### 16:37:31 INFO - Running pre-action listener: _resource_record_pre_action 16:37:31 INFO - Running main action method: install 16:37:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:32 INFO - Reading from file tmpfile_stdout 16:37:32 INFO - Detecting whether we're running mozinstall >=1.0... 16:37:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:37:32 INFO - Reading from file tmpfile_stdout 16:37:32 INFO - Output received: 16:37:32 INFO - Usage: mozinstall [options] installer 16:37:32 INFO - Options: 16:37:32 INFO - -h, --help show this help message and exit 16:37:32 INFO - -d DEST, --destination=DEST 16:37:32 INFO - Directory to install application into. [default: 16:37:32 INFO - "/builds/slave/test"] 16:37:32 INFO - --app=APP Application being installed. [default: firefox] 16:37:32 INFO - mkdir: /builds/slave/test/build/application 16:37: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'] 16:37: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 16:38:06 INFO - Reading from file tmpfile_stdout 16:38:06 INFO - Output received: 16:38:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:38:06 INFO - Running post-action listener: _resource_record_post_action 16:38:06 INFO - ##### 16:38:06 INFO - ##### Running run-tests step. 16:38:06 INFO - ##### 16:38:06 INFO - Running pre-action listener: _resource_record_pre_action 16:38:06 INFO - Running main action method: run_tests 16:38:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:38:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:38:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:38:06 INFO - 2016-02-16 16:38:06.109 screenresolution[2261:25555] starting screenresolution argv=screenresolution get 16:38:06 INFO - 2016-02-16 16:38:06.112 screenresolution[2261:25555] Display 0: 1600x1200x32@60 16:38:06 INFO - 2016-02-16 16:38:06.118 screenresolution[2262:25557] starting screenresolution argv=screenresolution list 16:38:06 INFO - Available Modes on Display 0 16:38:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:38:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:38:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:38:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:38:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:38:06 INFO - Intel Iris: 16:38:06 INFO - Chipset Model: Intel Iris 16:38:06 INFO - Type: GPU 16:38:06 INFO - Bus: Built-In 16:38:06 INFO - VRAM (Dynamic, Max): 1536 MB 16:38:06 INFO - Vendor: Intel (0x8086) 16:38:06 INFO - Device ID: 0x0a2e 16:38:06 INFO - Revision ID: 0x0009 16:38:06 INFO - Displays: 16:38:06 INFO - Display: 16:38:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:38:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:38:06 INFO - Display Serial Number: 1600x1200 60 16:38:06 INFO - Main Display: Yes 16:38:06 INFO - Mirror: Off 16:38:06 INFO - Online: Yes 16:38:06 INFO - Rotation: Supported 16:38:06 INFO - Return code: 0 16:38:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:38:06 INFO - Python 2.7.3 16:38:06 INFO - Return code: 0 16:38:06 INFO - grabbing minidump binary from tooltool 16:38: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')]} 16:38: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 0x1098dad30>, '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 0x1096fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098d1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:38: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 16:38: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 16:38:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:38:06 INFO - Return code: 0 16:38:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:38:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:38:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:38:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:38:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:38:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:38:07 INFO - Return code: 0 16:38: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', 'https://queue.taskcluster.net/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0077', '--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 16:38: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 https://queue.taskcluster.net/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0077 --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 16:38:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MrKBKjFLks/Render', 16:38:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:07 INFO - 'HOME': '/Users/cltbld', 16:38:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:07 INFO - 'LOGNAME': 'cltbld', 16:38:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:38:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:07 INFO - 'MOZ_NO_REMOTE': '1', 16:38:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:38:07 INFO - 'NO_EM_RESTART': '1', 16:38:07 INFO - 'PAGER': '/bin/cat', 16:38:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:07 INFO - 'PWD': '/builds/slave/test', 16:38:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:38:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:07 INFO - 'SHELL': '/bin/bash', 16:38:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1SuNbQVHht/Listeners', 16:38:07 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:38:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:07 INFO - 'USER': 'cltbld', 16:38:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:07 INFO - 'XPC_FLAGS': '0x0', 16:38:07 INFO - 'XPC_SERVICE_NAME': '0', 16:38:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38: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', 'https://queue.taskcluster.net/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0077', '--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 16:38:07 INFO - mozversion application_buildid: 20160216143851 16:38:07 INFO - mozversion application_changeset: b8003b4c63c378bd43065f6faf540b5288d9f617 16:38:07 INFO - mozversion application_display_name: Nightly 16:38:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:38:07 INFO - mozversion application_name: Firefox 16:38:07 INFO - mozversion application_remotingname: firefox 16:38:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:38:07 INFO - mozversion application_vendor: Mozilla 16:38:07 INFO - mozversion application_version: 47.0a1 16:38:07 INFO - mozversion platform_buildid: 20160216143851 16:38:07 INFO - mozversion platform_changeset: b8003b4c63c378bd43065f6faf540b5288d9f617 16:38:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:38:07 INFO - mozversion platform_version: 47.0a1 16:38:07 INFO - using testdate: 1455669487 16:38:07 INFO - actual date: 1455669487 16:38:07 INFO - starting webserver on 'localhost:50197' 16:38:07 INFO - SUITE-START | Running 2 tests 16:38:07 INFO - TEST-START | dromaeo_css 16:38:07 INFO - operating with platform_type : mac_ 16:38:07 INFO - Initialising browser for dromaeo_css test... 16:38:07 INFO - TEST-INFO | started process 2280 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpZ8tBYn/profile http://localhost:50197/getInfo.html) 16:38:10 INFO - PROCESS | 2280 | __metrics Screen width/height:1600/1200 16:38:10 INFO - PROCESS | 2280 | colorDepth:24 16:38:10 INFO - PROCESS | 2280 | Browser inner width/height: 1024/689 16:38:10 INFO - PROCESS | 2280 | __metrics 16:38:10 ERROR - PROCESS | 2280 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 16:38:11 INFO - TEST-INFO | 2280: exit 0 16:38:11 INFO - Browser initialized. 16:38:11 INFO - Running cycle 1/1 for dromaeo_css test... 16:38:11 INFO - TEST-INFO | started process 2284 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpZ8tBYn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:23 INFO - PROCESS | 2284 | RSS: Main: 256819200 16:38:23 INFO - PROCESS | 2284 | 16:39:13 INFO - PROCESS | 2284 | 1455669553204 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] 16:41:24 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:50197/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50197/tests/dromaeo/cssquery-ext.html) 16:41:25 INFO - PROCESS | 2284 | RSS: Main: 272871424 16:41:25 INFO - PROCESS | 2284 | 16:44:27 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:50197/tests/dromaeo/cssquery-ext.html (next: http://localhost:50197/tests/dromaeo/cssquery-jquery.html) 16:44:28 INFO - PROCESS | 2284 | RSS: Main: 284147712 16:44:28 INFO - PROCESS | 2284 | 16:47:29 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:50197/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50197/tests/dromaeo/cssquery-mootools.html) 16:47:30 INFO - PROCESS | 2284 | RSS: Main: 285757440 16:47:30 INFO - PROCESS | 2284 | 16:50:32 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:50197/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50197/tests/dromaeo/cssquery-prototype.html) 16:50:32 INFO - PROCESS | 2284 | RSS: Main: 287703040 16:50:32 INFO - PROCESS | 2284 | 16:53:35 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:50197/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50197/tests/dromaeo/cssquery-yui.html) 16:53:35 INFO - PROCESS | 2284 | RSS: Main: 291221504 16:53:35 INFO - PROCESS | 2284 | 16:56:38 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:50197/tests/dromaeo/cssquery-yui.html (next: http://localhost:50197/tests/dromaeo/cssquery-dojo.html) 16:56:38 INFO - PROCESS | 2284 | RSS: Main: 292220928 16:56:38 INFO - PROCESS | 2284 | 16:56:38 INFO - PROCESS | 2284 | __start_tp_report 16:56:38 INFO - PROCESS | 2284 | _x_x_mozilla_page_load 16:56:38 INFO - PROCESS | 2284 | _x_x_mozilla_page_load_details 16:56:38 INFO - PROCESS | 2284 | |i|pagename|runs| 16:56:38 INFO - PROCESS | 2284 | |0;dojo.html;2940.529515277555;3512.701420379268;3527.9647203527975;3544.8759293424737;3579.3378225028373;5771.480566748992;5780.682062486561;5793.681347525884;5821.010428227206;5851.824445266643;5079.949200508003;5703.914441283374;5771.624844385123;5846.21076154719;5888.293404791431;5215.035218484583;5217.921731174036;5262.631615786897;5347.759350829222;5351.518363347298;5398.2982212312345;5406.513413792758;5421.078416669156;5421.159720243349;5423.918641220384;4927.556519913207;5252.6323157379;5329.920051199235;5336.412994570614;5348.732563371855;4197.454330936989;4378.233809083429;4933.383327084114;5279.313689220415;5295.973520132413;5188.818391356284;5230.895382092375;5258.842234732964;5267.3679158500845;5297.417284098746;5685.4883060524335;5723.456271654228;5769.336526299488;5777.277840269966;5815.651060936315;6299.149614801989;6299.905501417483;6303.432691057781;6318.968405157991;6373.362663733589;6208.689565521751;6228.408301211378;6277.372262773686;6280.089387038899;6301.275353334379;5926.140709597084;5945.137954996501;5946.672932988728;5955.702214889238;5956.106584012389;6245.500359971283;6317.842053948688;6329.177206963065;6335.303116657164;6339.6196228225535;6120.081987701791;6126.36500017443;6219.253689557192;6236.844078898064;6241;6249.281332646713;6271.7804876830005;6290.150829637941;6298.7795427160745;6308.621482711052;6075;6230.190075290274;6264.37356264379;6302.779402720883;6316.431521163117;6281.466075383643;6299.464545513682;6303.558750887486;6310.1481300024825;6320.431161195423;4888.853334399902;4914.852554423373;4938.283948827472;4949.406071271471;4958.628102892298;4375.934360984587;4398.890027749332;4400.471943366816;4495.213337665896;4522.8643140705835;5688.971555142198;5739.71301434935;5748.310202775694;5752.33848107473;5753.194552762617;6215.192025036717;6271.905921411182;6277.497800175975;6292;6299.905501417483;5721.199032135504;5741.770329186869;5767.653940763567;5775.249217601685;5822.388649191774;5417.5395091416885;5446.673199608036;5447.673139611636;5457.808976685797;5465.808696695596;6188.257409110935;6272.153259309935;6329;6357.618542887441;6367.458766004756;5151.871203219949;6227.06594010902;6265.091561723433;6280.937190628035;6287.46556542699;6335.936640633535;6340.461060809698;6368.076628888878;6392.840178995376;6393.104965304768;6117.583823141572;6145.371476558805;6236.532260080421;6265.997440409513;6266.154069200599;6261.342559031418;6285.811425657238;6299.118123462627;6300.054991751274;6305.936940630535;5878.500327472042;6169.784057557964;6178.69106544662;6183.165272688309;6197.5351848610635;6131.478824299985;6158.661273629993;6171.382861713792;6188.1027251049245;6205.379462053758;5088.414832294334;6001.339852616122;6033.728482218398;6063.818085457443;6118.908216376669;4963;5372.785088596413;6208.441240288395;6211.565190436626;6271.31015588294;6120.418560236771;6124.510039196943;6128.233970753656;6135.969320153371;6163.322034576104 16:56:38 INFO - PROCESS | 2284 | |1;ext.html;446.64714875248546;496.4886167247734;496.9006198760249;533.825583715825;585.3853453873437;31685.524717129232;37481.81259093701;37619;37654;37701;38734;38947.41578876319;39153.41269880947;39202.411963820494;39301.60698393015;8351.83296334073;9448.244140468745;9459.432434053979;9754.609815607402;9763.755906102333;9629.422234665943;9631.566579503904;9647.17998970085;9722.465264410455;9760.951195244013;8806;9688.224942004657;9788.559514821814;9790.559424825864;9844.310898237127;9643.855342169803;9682.903170968271;9716.708498745049;9747.853782193273;9762.316637835354;9547.665831695927;9559.569819358145;9653.662121825773;9687.17658998986;9705;37891;37988.62011379879;38026.049348766224;38350.23299533994;38388.736957358655;2973.197236746088;2984.1942675477717;3247.723943464808;3315.801051936867;3568.357695614788;28805;29074.563881541795;29176.708232917612;29238.56142157869;29253.70746292531;2812.4796912571037;2828.4060347327086;2840.67332256789;2863.2269287292315;2939.867705953216;480748;493136;493362;493551;493759.5312023453;60221.09668354978;71198.2880171202;72031.6398418015;72443;72765;59099.52251193755;70650;70729.64635176791;72053.27946720466;72300;16148;16482.093484858447;16532.256048477848;16665;16782.580435488966;12390.81413778794;12692.936535317449;12716.791904769032;12831.871681283068;12921.353932303347;21757.564848702936;21957.780422195894;22488.32535023952;22540.887295563418;22546.661800073012;8454.77405776159;9861.753456163653;10079.177830207555;10107.69676909694;10110.646127385506;920.861870719384;921.4839689773748;946.9715908522618;1059.0733108530037;1062.86182796236;25827.096051638102;29557.45310562746;29565;29867;31608.893688721244;985.0592683986775;994.9502524873727;1009.7475631092227;1017.7760892603616;1050.422267752733;14379.065360751518;14582.708345833023;14895.957282990303;15827.762583561256;15907.920460397856;615211;618859;624502;631229;633928;49356.75321623369;57605.71197143987;58153;58174.709126454094;58308.4169158303;1425.287356321839;1435.6769726811383;1451.361400983564;1461.101422625099;1560.7736878152605;30040.549391759578;30142;30316;30327.69672303337;30675.539866901567;49222.75388623034;49444.258336124265;49963.75018124886;50029.49970500248;50061.49938500714;347882;411131;412237;412574.93712531246;413889.93055034534;32324.515132272565;34530.65469345274;44832.551674482835;44874.551254487036;44923.550764493244;35509.82245088861;40378.39432408458;40995.590044099175;41656.791716041225;42081;34263;34869.302613948086;35756.28487430289;35817.283654326246;36019.639803601625;34700.74108869601;34928.47607285842;35439.29121417506;35475.290494190485;35577.46633800443;34736.82631586927;34791.9562413128;34884.30231395307;36742.8162859184;37528.62471375251;30486.390272194876;31926.36147276995;32010;32897;33258.334833303685;25548.361290967874;25834.61248081318;26083.668351710014;26312.8684356577;27244.863775680995 16:56:38 INFO - PROCESS | 2284 | |2;jquery.html;287.4165444148378;367.4910249304712;368.05960770232065;368.4454895382449;369.54176820742254;15310.387584496606;18764.53088672782;19403.70894436581;19546.12042458089;20798.480037999077;11510.597129100483;18876.33932812352;19044.809551904476;19124.80875191248;19213.903930480326;5196.948030519684;5302.840914772543;5305.7877684892555;5375.516203541681;5376;5114.43741188469;5359.598030147735;5365.222042803791;5367.490088441611;5378.838634840961;3871.322518559255;5356.437574054727;5360.865978350534;5362.597805164609;5675.489205971462;5848.883022339572;5885.4997325227405;5891.293044834626;5900.321463031763;5915.349311575723;4789.784459699287;5399.757010934517;5425.565954723652;5633.577481688849;5699.145128230757;13177.472901083946;16547.503574892773;23936.760632393627;24562.771861407036;24632.261032169063;2007.5984803039305;2182.01809185867;2278.1798552521077;2378.797802186816;2387.236084452976;9600.32797704161;9753.561089750978;12750.362481875869;13726.245056521888;13901.88784897216;1641.3844808196927;1699.7195462748632;1727.7494763259258;1732.7747392838976;1794.4168145352683;99680;102458;103248;104309;104560;11196.8803119689;11328.94335528317;11330.830037549444;11337.093032557375;11380.146489013192;13536.526221582395;13593;13626;13641.931790340985;13644.863551364358;6306.306306306303;7761.9611901940125;8162.83674326522;8550.358723095793;8585.613647385882;8736.912630873738;8741.475511469333;8747.256483198998;8781.121887811169;8797.868031979526;3639.8544058237903;4491.146682130385;4495.078508905666;4514.345419914094;4581.610563102174;1850.518865095085;1891.5743957609702;1905.552195234119;1912.053533500926;1915.348781414298;352.95588051493564;392.6936989148469;393.5926316262654;399.4347997583445;420.97684627345177;11706.297622142698;11882.28706277626;11949.342786146672;11955.402229888645;12098.637040888787;431.6417373579921;438.40595992430434;445.3364486914474;450.8309383981007;451.1811062920788;5387.326584176978;10594;11174;11175.217734758651;11175.944120279346;596327;728903;733417;743352;755167;73798;106039.46980265049;106465.40301895478;110694;117648;1121.43928035982;1167.795635763755;1170.7307319316606;1171.1918776044672;1174.512577280436;17714.645707086045;18014.819851801316;18066.81933180704;18111.72832407541;18350.357737479124;50706.49293507018;50896.49103508917;50959.23561146512;51446;51564.22653660273;74187;74632;75439.86840197291;75573.24426755663;76575;7357.926420735724;7565.886511702439;7599.392048635986;7643.121041080124;7656.808579785327;11293.322400655657;11816.82274765862;11847.70380740454;11962.222455540363;12117.636470905887;9968.053034961667;10049.246306526893;10073.597056117966;10204.540795664065;10471.42407167613;5596.860078497907;8963.700263461891;9035.774105647411;9601.37591056579;10488.842667359842;9669;9682.370645907993;10490.580376784843;10628.36229826213;10956;7009.474289428212;7293.52592081513;7522.134954480086;7581.696732130653;7634.961825190839;7581.54510729358;10243.743906402102;10494.737631558966;10498.265121441425;10505.737356565842 16:56:38 INFO - PROCESS | 2284 | |3;mootools.html;1368.6509939965308;1521.5815650696059;1740.860731141508;1894.6684330242203;1918.8368988635966;7989.640466179021;8711;8787.956060219698;8960.910390896097;8968.058353872848;8694.521801300925;8787.560621968893;8849.07084756101;8899.243564297027;8900.866487002684;2493.2021753039035;2506.7618576235227;2509.736477669846;2511.635812807151;2518.6977562692505;2456.336789066951;2510.3598582361565;2513.170653684289;2514.5976643737004;2517.7356377580363;2196.6595177747477;2439.7682220189054;2476.566600844854;2500.824942254043;2505.060602274147;2450.15469662966;2461.7415171407015;2471.6292556116728;2499.8875050622764;2500.987100224412;2417.0815090265587;2503.1614409172766;2506.323292710958;2511.7864981476596;2512.748725127491;8865.42374745646;8877.33419993503;8890.155435233642;8937.50843703596;8943.50810705411;5459.317585301837;5496.780128794843;5589.329280486327;5615.2700148980775;5636.323641163046;3621.6016238213774;3715.4612581175847;3730.2166545025307;3751.549814022335;3779.055236190952;1050.390773351462;1067.2049323254225;1076.2036093290988;1103.5475455063386;1105.4141305108305;12268.938655306667;12368.567100151451;12380.947619452358;12407.193532420453;12409.93795031019;4933.186024306021;5022.8493145204975;5033.471485494044;5035.82374616894;5100.413452452941;10258.948705256425;10320.12278956297;10374.740631484274;10426.27016108865;10453.790924181474;5551.278333816578;5566.109422492463;5578.967890940108;5584.52531534816;5630.23991761107;4969.4782047884455;5073.771680274396;5090.669106508065;5106.463821298785;5112.463191364927;3811.104390468238;4044.8584299549375;4064.7967601619803;4083.8570650027104;4114.238865809834;1226.4419689041465;1337.806018127366;1338.3642769684516;1348.9595312140652;1362.6252780485247;1082.9458527073614;1083.2633809009792;1118.1390329446444;1238.8141778733082;1367.193355920012;8081.717139900075;8087.797805054803;8102.473339232931;8122.472039317426;8245.505269683837;1182.9704257393635;1195.0917302849896;1202.0744027099086;1203.5065623094665;1228.4533382644638;6131.591784722373;6172.506199504029;6181.196444462191;6254.093156492283;6310.432061114522;10669.35983840972;10919.563217471372;11019.504122314514;11100.94541018602;11119.221654484109;10674.412907290018;10787.083097936764;10844.186685998582;10876.782464350668;10919.617813376493;8361.289290410261;8401.495910245405;8435.831283374298;8438.240558349655;8443.746687599381;6614.768483103261;7735.651895664596;7881.172476889844;7887.290143887078;7905.762827115196;8422.873656895028;9592.23262139041;9686.75783105428;9813.803723925339;9851.704448866545;9966.003399659976;10117.392956422638;10220.897791021995;10229.74425639365;10229.74425639365;7464.552126872405;7541.47209695338;7557.05536807899;7580.31777140038;7689.154193038649;8189.918100818915;8280.544570048705;8370.748877533684;8400.831983360176;8466.788330291793;6518.2504012037325;6906.827329316808;7285.490015698851;7866.6853325868615;7953;7578.658960346687;7643.88534171999;7654;7698.345640620386;7771.417143714131;7872.803179920319;7875.960620197092;7877.8818317724135;7886.802829929068;7904.723334683258;6895.931040689529;7034.859302814018;7093.290670932865;7128.643567821485;7134.179569349383;7168.2831716827895;7186.568805871664;7297.16082650502;7311.817204569928;7312.780616581511 16:56:38 INFO - PROCESS | 2284 | |4;prototype.html;320.94383482890504;322.02426647258807;326.6276444852867;332.9866805327788;334.29630627529053;6917.1699396072545;7024.297570242973;7047.154341479017;7067.328603782646;7142.178649455314;7117.572945623253;7120.537165084266;7122.1453425589;7127.607981561012;7127.786166415003;4305.268104422255;5192.247124167013;5229.372475302969;5231.581473482112;5248.737563121847;4225.809838557272;4864.854054378375;5195.818146364878;5256.500632439931;5261.184516399964;5032.723200223986;5033.84898453047;5035.446100928895;5042.899142017158;5061.392632884059;5039.269305950635;5046.646734728571;5060.114479966028;5062.1900495920845;5072.2391641253735;4255.957440425587;4272.974486123308;4282.743035417885;4284.507281662618;4288.078063216423;6529.706163222666;6704.798856034278;6708.4968627352655;6712.664366781691;6783.389494945479;5908.67502287374;5918.644881307136;5922.644641321534;5929.436703513159;5943.227380440515;7420.628968551551;7426.220246874054;7431.702731890718;7432;7437.3306402423505;4489.506154323022;4618.145643056046;4698.389209402756;4725.3384526166365;4760.928586071212;7759.107702614215;7830.647620857075;7896.210378962115;7915.841683166362;7936.2063793620755;3957.2283404736377;4800.279958006327;4801.663883528119;4809.134355815987;4817.662763606514;4804.975975120172;4900.240462728283;4900.534449227318;4909.4354149273295;4909.7790599423115;5908.822735317947;5919.378465261086;5928.4960778334325;5933.821985340447;5935.169076329317;7464.962675186589;7465.402767778564;7469.9253007470315;7485.401167906554;7499.287567681062;1652.8512433880767;1679.5717092141426;1701.8723595730369;1702.8041775195763;1704.9573760656083;837.8031162676766;921.5484412637893;967.1295833749682;1063.6170978447753;1084.5607528950788;5552.833414997475;5937.851553711105;6512.283648798629;6859.485538584527;6906.136732908387;6541.247756507967;7414.925850741532;7496.137944136385;7770.45606807518;7773.766786996399;6702.19573651165;6859.485538584626;6873.690683919235;6904.516683832084;6935.029095926574;4116.156187981456;4128.525219599785;4135.483064616923;4140.213359461693;4145.875623731293;8050.838983220303;8080.878786818203;8101.797455063553;8103.3112185463715;8107.918920810835;7795.376369890395;8016.238457346542;8028.835818806358;8036.598170091472;8054.194580541899;8069.193080691884;8074.273315401642;8080.353571714249;8088.959555202304;8097.595120243965;7553.773386798405;7712;7746.264104910025;7746.65140068687;7901.881471778043;7694.846103078019;7725.49784264021;7735.381169506539;7745;7748.302652761278;7982.720604778805;8189.22202390772;8221.79445513867;8226.218509241613;8227.095019547965;4868.488808675038;4873.756312184306;4874.756262186947;4882.584980276716;4894.926576101432;7876;7900.881486777588;7922.603869806371;7927.563983980936;7963.243491868263;7402.481826272109;7541.5475071495885;7560;7572.583507907118;7608.01095857535;6077.6353418795015;6466.482681385572;7529.774106776806;7545.283198096172;7557.168711441847;7361.484696071224;7365.484416091036;7375.409967202718;7393.963030184815;7398.889016664647;7389.482736208413;7561.09266887977;7566.546007239584;7580.3556697681315;7593.848123037398;7369.410447164107;7395.7041718330665;7398.371138453292;7414.740484083031;7418.443616728875 16:56:38 INFO - PROCESS | 2284 | |5;yui.html;702.8313204830843;705.8059033765713;744.4639859301301;748.8689479341114;752.5973604121796;14795.926020369896;15070;15170.013949093314;15180.772288415683;15198.240087995597;14106.29468526572;14220.928895355535;14305.570832875004;14343.713125737479;14355.56933292003;712.4763298975249;858.8153546987396;859.9656013759442;873.6723728601775;890.536920801183;870.4385671242045;886.1979908183105;891.754767438953;893.0622846011662;893.2675206330812;771.8803585444265;899.4153800029967;924.8011677489338;937.4703292639637;938.6902322233681;882.8896387951506;899.5412339706731;912.8813254276902;925.7361651929201;927.9860802087974;677.8203775999364;684.9657517124124;686.6772616870063;691;692.2834865913806;14808.703825923421;14977.400903963828;15048.097114173184;15090.698186036218;15137.318820653098;10603.734906627318;11207.775844483065;11788.880056394628;12112;12281.078919081105;9162.496062716547;10508.527116279785;10678.946605267001;10720.46397680113;11375.943120284346;3424.880129195491;3479.3911065563425;3550.0237434705405;3565.322588708137;3713.461548075541;77256.22743772547;79486.80769788516;79636.60181699113;80868.59565702193;82692;8222.753317400488;8241.175882411711;9519.381240219502;9526.142647161789;9807.019298070278;20522.076506556943;20595.382138535868;20792.688109678365;20825.166993320097;20861.58276834455;7468.589227592426;7580.54516728998;7581.50720203185;7726.690932362755;7761.0298712660915;4211.684123690736;4222.265486548949;4227.154569086134;4274.572542745763;4286.271333873249;3576;3597.8380972856285;3612.0789198754674;3638.181409182913;3638.927221455609;663.5222639699409;668.1280928388403;670.3564578005072;680.0988689985788;680.2619158213394;537.1942086869695;545.9727013649301;573.2146958666654;602.9698515074228;604.2959951656271;8272.917270827214;8801.075887031897;9097.272218222526;9176.595234287446;9350.392224505522;498.4566822163786;519.8752299448105;592.7569696424531;601.1313651773233;665.0921492163162;3906.140649057203;4026.3960405938756;4033.6773058155277;4051.1897620476025;4118.345083413931;90778.09221907829;92796;96114.0388596119;97736;97923;82905.58547207226;84014.5799271012;84017.15982840094;84879;85214;68716.96924546135;70920;71775.6411217951;72051.63974180096;74695.62652186705;8478.152184781718;8784.516851573226;8874;8923.286137108886;8957.462552246887;50491;50731;51133.744331279595;51194.23208651948;52292.954140916205;63380;64322.67838660964;66486.00270995843;66535.33464665485;66584.33539161365;10911.836322455329;11145.2198346115;11269.98900076159;11471.942640286745;11817.172797904064;12140.33228172459;12229.816552751538;12354.938225309175;12414.81377779352;12475.688107797378;11189.664310070386;11291.548338066385;11431.714207144887;11678.182527223013;11718.88281117178;9478.086416672357;10349.63776267827;11588.130890183102;11710.824337635113;12118.151729378858;9039.864402034107;11117.110631149328;11253.831192531954;11350.205485616258;11780.646580602595;9084.63661453561;9196.770080748034;9285.303602229726;9391.671291504765;9568.90431095708;9161.86257206129;9267;9892.406455612687;10004.26177190599;10020.949895250476 16:56:38 INFO - PROCESS | 2284 | __end_tp_report 16:56:38 INFO - PROCESS | 2284 | __start_cc_report 16:56:38 INFO - PROCESS | 2284 | _x_x_mozilla_cycle_collect,362 16:56:38 INFO - PROCESS | 2284 | __end_cc_report 16:56:38 INFO - PROCESS | 2284 | __startTimestamp1455670598535__endTimestamp 16:56:38 INFO - PROCESS | 2284 | 16:56:38 INFO - PROCESS | 2284 | ------- Summary: start ------- 16:56:38 INFO - PROCESS | 2284 | Number of tests: 6 16:56:38 INFO - PROCESS | 2284 | 16:56:38 INFO - PROCESS | 2284 | [#0] dojo.html Cycles:165 Average:5768.99 Median:6063.82 stddev:668.92 (11.0%) stddev-sans-first:633.10 16:56:38 INFO - PROCESS | 2284 | Values: 2940.5 3512.7 3528.0 3544.9 3579.3 5771.5 5780.7 5793.7 5821.0 5851.8 5079.9 5703.9 5771.6 5846.2 5888.3 5215.0 5217.9 5262.6 5347.8 5351.5 5398.3 5406.5 5421.1 5421.2 5423.9 4927.6 5252.6 5329.9 5336.4 5348.7 4197.5 4378.2 4933.4 5279.3 5296.0 5188.8 5230.9 5258.8 5267.4 5297.4 5685.5 5723.5 5769.3 5777.3 5815.7 6299.1 6299.9 6303.4 6319.0 6373.4 6208.7 6228.4 6277.4 6280.1 6301.3 5926.1 5945.1 5946.7 5955.7 5956.1 6245.5 6317.8 6329.2 6335.3 6339.6 6120.1 6126.4 6219.3 6236.8 6241.0 6249.3 6271.8 6290.2 6298.8 6308.6 6075.0 6230.2 6264.4 6302.8 6316.4 6281.5 6299.5 6303.6 6310.1 6320.4 4888.9 4914.9 4938.3 4949.4 4958.6 4375.9 4398.9 4400.5 4495.2 4522.9 5689.0 5739.7 5748.3 5752.3 5753.2 6215.2 6271.9 6277.5 6292.0 6299.9 5721.2 5741.8 5767.7 5775.2 5822.4 5417.5 5446.7 5447.7 5457.8 5465.8 6188.3 6272.2 6329.0 6357.6 6367.5 5151.9 6227.1 6265.1 6280.9 6287.5 6335.9 6340.5 6368.1 6392.8 6393.1 6117.6 6145.4 6236.5 6266.0 6266.2 6261.3 6285.8 6299.1 6300.1 6305.9 5878.5 6169.8 6178.7 6183.2 6197.5 6131.5 6158.7 6171.4 6188.1 6205.4 5088.4 6001.3 6033.7 6063.8 6118.9 4963.0 5372.8 6208.4 6211.6 6271.3 6120.4 6124.5 6128.2 6136.0 6163.3 16:56:38 INFO - PROCESS | 2284 | 16:56:38 INFO - PROCESS | 2284 | [#1] ext.html Cycles:180 Average:65046.37 Median:37677.50 stddev:137019.89 (363.7%) stddev-sans-first:137318.42 16:56:38 INFO - PROCESS | 2284 | Values: 446.6 496.5 496.9 533.8 585.4 31685.5 37481.8 37619.0 37654.0 37701.0 38734.0 38947.4 39153.4 39202.4 39301.6 8351.8 9448.2 9459.4 9754.6 9763.8 9629.4 9631.6 9647.2 9722.5 9761.0 8806.0 9688.2 9788.6 9790.6 9844.3 9643.9 9682.9 9716.7 9747.9 9762.3 9547.7 9559.6 9653.7 9687.2 9705.0 37891.0 37988.6 38026.0 38350.2 38388.7 2973.2 2984.2 3247.7 3315.8 3568.4 28805.0 29074.6 29176.7 29238.6 29253.7 2812.5 2828.4 2840.7 2863.2 2939.9 480748.0 493136.0 493362.0 493551.0 493759.5 60221.1 71198.3 72031.6 72443.0 72765.0 59099.5 70650.0 70729.6 72053.3 72300.0 16148.0 16482.1 16532.3 16665.0 16782.6 12390.8 12692.9 12716.8 12831.9 12921.4 21757.6 21957.8 22488.3 22540.9 22546.7 8454.8 9861.8 10079.2 10107.7 10110.6 920.9 921.5 947.0 1059.1 1062.9 25827.1 29557.5 29565.0 29867.0 31608.9 985.1 995.0 1009.7 1017.8 1050.4 14379.1 14582.7 14896.0 15827.8 15907.9 615211.0 618859.0 624502.0 631229.0 633928.0 49356.8 57605.7 58153.0 58174.7 58308.4 1425.3 1435.7 1451.4 1461.1 1560.8 30040.5 30142.0 30316.0 30327.7 30675.5 49222.8 49444.3 49963.8 50029.5 50061.5 347882.0 411131.0 412237.0 412574.9 413889.9 32324.5 34530.7 44832.6 44874.6 44923.6 35509.8 40378.4 40995.6 41656.8 42081.0 34263.0 34869.3 35756.3 35817.3 36019.6 34700.7 34928.5 35439.3 35475.3 35577.5 34736.8 34792.0 34884.3 36742.8 37528.6 30486.4 31926.4 32010.0 32897.0 33258.3 25548.4 25834.6 26083.7 26312.9 27244.9 16:56:38 INFO - PROCESS | 2284 | 16:56:38 INFO - PROCESS | 2284 | [#2] jquery.html Cycles:180 Average:36091.16 Median:367.78 stddev:117638.74 (31986.6%) stddev-sans-first:117938.03 16:56:38 INFO - PROCESS | 2284 | Values: 287.4 367.5 368.1 368.4 369.5 15310.4 18764.5 19403.7 19546.1 20798.5 11510.6 18876.3 19044.8 19124.8 19213.9 5196.9 5302.8 5305.8 5375.5 5376.0 5114.4 5359.6 5365.2 5367.5 5378.8 3871.3 5356.4 5360.9 5362.6 5675.5 5848.9 5885.5 5891.3 5900.3 5915.3 4789.8 5399.8 5425.6 5633.6 5699.1 13177.5 16547.5 23936.8 24562.8 24632.3 2007.6 2182.0 2278.2 2378.8 2387.2 9600.3 9753.6 12750.4 13726.2 13901.9 1641.4 1699.7 1727.7 1732.8 1794.4 99680.0 102458.0 103248.0 104309.0 104560.0 11196.9 11328.9 11330.8 11337.1 11380.1 13536.5 13593.0 13626.0 13641.9 13644.9 6306.3 7762.0 8162.8 8550.4 8585.6 8736.9 8741.5 8747.3 8781.1 8797.9 3639.9 4491.1 4495.1 4514.3 4581.6 1850.5 1891.6 1905.6 1912.1 1915.3 353.0 392.7 393.6 399.4 421.0 11706.3 11882.3 11949.3 11955.4 12098.6 431.6 438.4 445.3 450.8 451.2 5387.3 10594.0 11174.0 11175.2 11175.9 596327.0 728903.0 733417.0 743352.0 755167.0 73798.0 106039.5 106465.4 110694.0 117648.0 1121.4 1167.8 1170.7 1171.2 1174.5 17714.6 18014.8 18066.8 18111.7 18350.4 50706.5 50896.5 50959.2 51446.0 51564.2 74187.0 74632.0 75439.9 75573.2 76575.0 7357.9 7565.9 7599.4 7643.1 7656.8 11293.3 11816.8 11847.7 11962.2 12117.6 9968.1 10049.2 10073.6 10204.5 10471.4 5596.9 8963.7 9035.8 9601.4 10488.8 9669.0 9682.4 10490.6 10628.4 10956.0 7009.5 7293.5 7522.1 7581.7 7635.0 7581.5 10243.7 10494.7 10498.3 10505.7 16:56:38 INFO - PROCESS | 2284 | 16:56:38 INFO - PROCESS | 2284 | [#3] mootools.html Cycles:180 Average:6162.57 Median:5095.54 stddev:3242.82 (63.6%) stddev-sans-first:3231.89 16:56:38 INFO - PROCESS | 2284 | Values: 1368.7 1521.6 1740.9 1894.7 1918.8 7989.6 8711.0 8788.0 8960.9 8968.1 8694.5 8787.6 8849.1 8899.2 8900.9 2493.2 2506.8 2509.7 2511.6 2518.7 2456.3 2510.4 2513.2 2514.6 2517.7 2196.7 2439.8 2476.6 2500.8 2505.1 2450.2 2461.7 2471.6 2499.9 2501.0 2417.1 2503.2 2506.3 2511.8 2512.7 8865.4 8877.3 8890.2 8937.5 8943.5 5459.3 5496.8 5589.3 5615.3 5636.3 3621.6 3715.5 3730.2 3751.5 3779.1 1050.4 1067.2 1076.2 1103.5 1105.4 12268.9 12368.6 12380.9 12407.2 12409.9 4933.2 5022.8 5033.5 5035.8 5100.4 10258.9 10320.1 10374.7 10426.3 10453.8 5551.3 5566.1 5579.0 5584.5 5630.2 4969.5 5073.8 5090.7 5106.5 5112.5 3811.1 4044.9 4064.8 4083.9 4114.2 1226.4 1337.8 1338.4 1349.0 1362.6 1082.9 1083.3 1118.1 1238.8 1367.2 8081.7 8087.8 8102.5 8122.5 8245.5 1183.0 1195.1 1202.1 1203.5 1228.5 6131.6 6172.5 6181.2 6254.1 6310.4 10669.4 10919.6 11019.5 11100.9 11119.2 10674.4 10787.1 10844.2 10876.8 10919.6 8361.3 8401.5 8435.8 8438.2 8443.7 6614.8 7735.7 7881.2 7887.3 7905.8 8422.9 9592.2 9686.8 9813.8 9851.7 9966.0 10117.4 10220.9 10229.7 10229.7 7464.6 7541.5 7557.1 7580.3 7689.2 8189.9 8280.5 8370.7 8400.8 8466.8 6518.3 6906.8 7285.5 7866.7 7953.0 7578.7 7643.9 7654.0 7698.3 7771.4 7872.8 7876.0 7877.9 7886.8 7904.7 6895.9 7034.9 7093.3 7128.6 7134.2 7168.3 7186.6 7297.2 7311.8 7312.8 16:56:38 INFO - PROCESS | 2284 | 16:56:38 INFO - PROCESS | 2284 | [#4] prototype.html Cycles:180 Average:6089.94 Median:6979.66 stddev:2002.57 (28.7%) stddev-sans-first:1960.81 16:56:38 INFO - PROCESS | 2284 | Values: 320.9 322.0 326.6 333.0 334.3 6917.2 7024.3 7047.2 7067.3 7142.2 7117.6 7120.5 7122.1 7127.6 7127.8 4305.3 5192.2 5229.4 5231.6 5248.7 4225.8 4864.9 5195.8 5256.5 5261.2 5032.7 5033.8 5035.4 5042.9 5061.4 5039.3 5046.6 5060.1 5062.2 5072.2 4256.0 4273.0 4282.7 4284.5 4288.1 6529.7 6704.8 6708.5 6712.7 6783.4 5908.7 5918.6 5922.6 5929.4 5943.2 7420.6 7426.2 7431.7 7432.0 7437.3 4489.5 4618.1 4698.4 4725.3 4760.9 7759.1 7830.6 7896.2 7915.8 7936.2 3957.2 4800.3 4801.7 4809.1 4817.7 4805.0 4900.2 4900.5 4909.4 4909.8 5908.8 5919.4 5928.5 5933.8 5935.2 7465.0 7465.4 7469.9 7485.4 7499.3 1652.9 1679.6 1701.9 1702.8 1705.0 837.8 921.5 967.1 1063.6 1084.6 5552.8 5937.9 6512.3 6859.5 6906.1 6541.2 7414.9 7496.1 7770.5 7773.8 6702.2 6859.5 6873.7 6904.5 6935.0 4116.2 4128.5 4135.5 4140.2 4145.9 8050.8 8080.9 8101.8 8103.3 8107.9 7795.4 8016.2 8028.8 8036.6 8054.2 8069.2 8074.3 8080.4 8089.0 8097.6 7553.8 7712.0 7746.3 7746.7 7901.9 7694.8 7725.5 7735.4 7745.0 7748.3 7982.7 8189.2 8221.8 8226.2 8227.1 4868.5 4873.8 4874.8 4882.6 4894.9 7876.0 7900.9 7922.6 7927.6 7963.2 7402.5 7541.5 7560.0 7572.6 7608.0 6077.6 6466.5 7529.8 7545.3 7557.2 7361.5 7365.5 7375.4 7394.0 7398.9 7389.5 7561.1 7566.5 7580.4 7593.8 7369.4 7395.7 7398.4 7414.7 7418.4 16:56:38 INFO - PROCESS | 2284 | 16:56:38 INFO - PROCESS | 2284 | [#5] yui.html Cycles:180 Average:18537.91 Median:33574.76 stddev:26286.58 (78.3%) stddev-sans-first:26326.21 16:56:38 INFO - PROCESS | 2284 | Values: 702.8 705.8 744.5 748.9 752.6 14795.9 15070.0 15170.0 15180.8 15198.2 14106.3 14220.9 14305.6 14343.7 14355.6 712.5 858.8 860.0 873.7 890.5 870.4 886.2 891.8 893.1 893.3 771.9 899.4 924.8 937.5 938.7 882.9 899.5 912.9 925.7 928.0 677.8 685.0 686.7 691.0 692.3 14808.7 14977.4 15048.1 15090.7 15137.3 10603.7 11207.8 11788.9 12112.0 12281.1 9162.5 10508.5 10678.9 10720.5 11375.9 3424.9 3479.4 3550.0 3565.3 3713.5 77256.2 79486.8 79636.6 80868.6 82692.0 8222.8 8241.2 9519.4 9526.1 9807.0 20522.1 20595.4 20792.7 20825.2 20861.6 7468.6 7580.5 7581.5 7726.7 7761.0 4211.7 4222.3 4227.2 4274.6 4286.3 3576.0 3597.8 3612.1 3638.2 3638.9 663.5 668.1 670.4 680.1 680.3 537.2 546.0 573.2 603.0 604.3 8272.9 8801.1 9097.3 9176.6 9350.4 498.5 519.9 592.8 601.1 665.1 3906.1 4026.4 4033.7 4051.2 4118.3 90778.1 92796.0 96114.0 97736.0 97923.0 82905.6 84014.6 84017.2 84879.0 85214.0 68717.0 70920.0 71775.6 72051.6 74695.6 8478.2 8784.5 8874.0 8923.3 8957.5 50491.0 50731.0 51133.7 51194.2 52293.0 63380.0 64322.7 66486.0 66535.3 66584.3 10911.8 11145.2 11270.0 11471.9 11817.2 12140.3 12229.8 12354.9 12414.8 12475.7 11189.7 11291.5 11431.7 11678.2 11718.9 9478.1 10349.6 11588.1 11710.8 12118.2 9039.9 11117.1 11253.8 11350.2 11780.6 9084.6 9196.8 9285.3 9391.7 9568.9 9161.9 9267.0 9892.4 10004.3 10020.9 16:56:38 INFO - PROCESS | 2284 | -------- Summary: end -------- 16:56:38 INFO - PROCESS | 2284 | 16:56:39 INFO - TEST-INFO | 2284: exit 0 16:56:39 INFO - TEST-OK | dromaeo_css | took 1111131ms 16:56:39 INFO - TEST-START | kraken 16:56:39 INFO - operating with platform_type : mac_ 16:56:39 INFO - Initialising browser for kraken test... 16:56:39 INFO - TEST-INFO | started process 2290 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpv1EKc2/profile http://localhost:50197/getInfo.html) 16:56:41 INFO - PROCESS | 2290 | __metrics Screen width/height:1600/1200 16:56:41 INFO - PROCESS | 2290 | colorDepth:24 16:56:41 INFO - PROCESS | 2290 | Browser inner width/height: 1024/689 16:56:41 INFO - PROCESS | 2290 | __metrics 16:56:41 ERROR - PROCESS | 2290 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 16:56:42 INFO - TEST-INFO | 2290: exit 0 16:56:42 INFO - Browser initialized. 16:56:42 INFO - Running cycle 1/1 for kraken test... 16:56:42 INFO - TEST-INFO | started process 2293 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpv1EKc2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:54 INFO - PROCESS | 2293 | RSS: Main: 255406080 16:56:54 INFO - PROCESS | 2293 | 16:56:57 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:50197/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50197/tests/kraken/driver.html?testName=audio-beat-detection) 16:56:57 INFO - PROCESS | 2293 | RSS: Main: 268201984 16:56:57 INFO - PROCESS | 2293 | 16:57:00 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:50197/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50197/tests/kraken/driver.html?testName=audio-dft) 16:57:00 INFO - PROCESS | 2293 | RSS: Main: 278265856 16:57:00 INFO - PROCESS | 2293 | 16:57:04 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:50197/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50197/tests/kraken/driver.html?testName=audio-fft) 16:57:04 INFO - PROCESS | 2293 | RSS: Main: 281513984 16:57:04 INFO - PROCESS | 2293 | 16:57:06 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:50197/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50197/tests/kraken/driver.html?testName=audio-oscillator) 16:57:07 INFO - PROCESS | 2293 | RSS: Main: 281952256 16:57:07 INFO - PROCESS | 2293 | 16:57:09 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:50197/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50197/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:57:10 INFO - PROCESS | 2293 | RSS: Main: 283213824 16:57:10 INFO - PROCESS | 2293 | 16:57:13 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:50197/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50197/tests/kraken/driver.html?testName=imaging-darkroom) 16:57:13 INFO - PROCESS | 2293 | RSS: Main: 283389952 16:57:13 INFO - PROCESS | 2293 | 16:57:16 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:50197/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50197/tests/kraken/driver.html?testName=imaging-desaturate) 16:57:17 INFO - PROCESS | 2293 | RSS: Main: 283234304 16:57:17 INFO - PROCESS | 2293 | 16:57:20 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:50197/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50197/tests/kraken/driver.html?testName=json-parse-financial) 16:57:20 INFO - PROCESS | 2293 | RSS: Main: 283533312 16:57:20 INFO - PROCESS | 2293 | 16:57:22 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:50197/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50197/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:57:22 INFO - PROCESS | 2293 | RSS: Main: 282787840 16:57:22 INFO - PROCESS | 2293 | 16:57:24 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:50197/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50197/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:57:25 INFO - PROCESS | 2293 | RSS: Main: 284401664 16:57:25 INFO - PROCESS | 2293 | 16:57:27 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:50197/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50197/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:57:28 INFO - PROCESS | 2293 | RSS: Main: 284385280 16:57:28 INFO - PROCESS | 2293 | 16:57:30 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:50197/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50197/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:57:31 INFO - PROCESS | 2293 | RSS: Main: 282423296 16:57:31 INFO - PROCESS | 2293 | 16:57:34 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:50197/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50197/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:57:34 INFO - PROCESS | 2293 | RSS: Main: 284667904 16:57:34 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:50197/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50197/tests/kraken/driver.html?testName=ai-astar) 16:57:36 INFO - PROCESS | 2293 | RSS: Main: 285224960 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | __start_tp_report 16:57:36 INFO - PROCESS | 2293 | _x_x_mozilla_page_load 16:57:36 INFO - PROCESS | 2293 | _x_x_mozilla_page_load_details 16:57:36 INFO - PROCESS | 2293 | |i|pagename|runs| 16:57:36 INFO - PROCESS | 2293 | |0;ai-astar;116;111;114;115;115;127;114;114;116;112 16:57:36 INFO - PROCESS | 2293 | |1;audio-beat-detection;154;123;145;152;118;165;142;120;156;121 16:57:36 INFO - PROCESS | 2293 | |2;audio-dft;195;269;236;206;214;237;261;273;199;201 16:57:36 INFO - PROCESS | 2293 | |3;audio-fft;73;90;101;142;48;67;83;91;135;59 16:57:36 INFO - PROCESS | 2293 | |4;audio-oscillator;83;90;150;62;112;67;114;106;116;149 16:57:36 INFO - PROCESS | 2293 | |5;imaging-gaussian-blur;86;93;121;137;112;92;126;104;86;95 16:57:36 INFO - PROCESS | 2293 | |6;imaging-darkroom;95;117;122;96;97;94;96;95;95;114 16:57:36 INFO - PROCESS | 2293 | |7;imaging-desaturate;94;92;91;91;101;92;91;95;93;93 16:57:36 INFO - PROCESS | 2293 | |8;json-parse-financial;51;61;55;54;57;55;57;61;55;54 16:57:36 INFO - PROCESS | 2293 | |9;json-stringify-tinderbox;63;63;75;72;66;74;91;97;97;88 16:57:36 INFO - PROCESS | 2293 | |10;stanford-crypto-aes;99;108;86;83;96;104;110;84;87;84 16:57:36 INFO - PROCESS | 2293 | |11;stanford-crypto-ccm;129;121;136;110;121;125;110;136;138;132 16:57:36 INFO - PROCESS | 2293 | |12;stanford-crypto-pbkdf2;140;174;126;171;162;153;175;181;175;139 16:57:36 INFO - PROCESS | 2293 | |13;stanford-crypto-sha256-iterative;68;70;93;95;95;92;96;87;69;73 16:57:36 INFO - PROCESS | 2293 | __end_tp_report 16:57:36 INFO - PROCESS | 2293 | __start_cc_report 16:57:36 INFO - PROCESS | 2293 | _x_x_mozilla_cycle_collect,889 16:57:36 INFO - PROCESS | 2293 | __end_cc_report 16:57:36 INFO - PROCESS | 2293 | __startTimestamp1455670656863__endTimestamp 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | ------- Summary: start ------- 16:57:36 INFO - PROCESS | 2293 | Number of tests: 14 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.00 stddev:4.38 (3.8%) stddev-sans-first:4.64 16:57:36 INFO - PROCESS | 2293 | Values: 116.0 111.0 114.0 115.0 115.0 127.0 114.0 114.0 116.0 112.0 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:148.50 stddev:17.58 (11.8%) stddev-sans-first:17.86 16:57:36 INFO - PROCESS | 2293 | Values: 154.0 123.0 145.0 152.0 118.0 165.0 142.0 120.0 156.0 121.0 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | [#2] audio-dft Cycles:10 Average:229.10 Median:236.50 stddev:30.31 (12.8%) stddev-sans-first:29.53 16:57:36 INFO - PROCESS | 2293 | Values: 195.0 269.0 236.0 206.0 214.0 237.0 261.0 273.0 199.0 201.0 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | [#3] audio-fft Cycles:10 Average:88.90 Median:70.00 stddev:30.61 (43.7%) stddev-sans-first:31.92 16:57:36 INFO - PROCESS | 2293 | Values: 73.0 90.0 101.0 142.0 48.0 67.0 83.0 91.0 135.0 59.0 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:106.00 stddev:30.21 (28.5%) stddev-sans-first:30.99 16:57:36 INFO - PROCESS | 2293 | Values: 83.0 90.0 150.0 62.0 112.0 67.0 114.0 106.0 116.0 149.0 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | [#5] imaging-gaussian-blur Cycles:10 Average:105.20 Median:86.00 stddev:17.97 (20.9%) stddev-sans-first:17.66 16:57:36 INFO - PROCESS | 2293 | Values: 86.0 93.0 121.0 137.0 112.0 92.0 126.0 104.0 86.0 95.0 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | [#6] imaging-darkroom Cycles:10 Average:102.10 Median:95.00 stddev:10.94 (11.5%) stddev-sans-first:11.30 16:57:36 INFO - PROCESS | 2293 | Values: 95.0 117.0 122.0 96.0 97.0 94.0 96.0 95.0 95.0 114.0 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:92.50 stddev:3.02 (3.3%) stddev-sans-first:3.19 16:57:36 INFO - PROCESS | 2293 | Values: 94.0 92.0 91.0 91.0 101.0 92.0 91.0 95.0 93.0 93.0 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:3.13 (5.6%) stddev-sans-first:2.74 16:57:36 INFO - PROCESS | 2293 | Values: 51.0 61.0 55.0 54.0 57.0 55.0 57.0 61.0 55.0 54.0 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | [#9] json-stringify-tinderbox Cycles:10 Average:78.60 Median:81.50 stddev:13.51 (16.6%) stddev-sans-first:13.10 16:57:36 INFO - PROCESS | 2293 | Values: 63.0 63.0 75.0 72.0 66.0 74.0 91.0 97.0 97.0 88.0 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | [#10] stanford-crypto-aes Cycles:10 Average:94.10 Median:85.00 stddev:10.62 (12.5%) stddev-sans-first:11.11 16:57:36 INFO - PROCESS | 2293 | Values: 99.0 108.0 86.0 83.0 96.0 104.0 110.0 84.0 87.0 84.0 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:130.50 stddev:10.28 (7.9%) stddev-sans-first:10.84 16:57:36 INFO - PROCESS | 2293 | Values: 129.0 121.0 136.0 110.0 121.0 125.0 110.0 136.0 138.0 132.0 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:172.50 stddev:19.02 (11.0%) stddev-sans-first:18.81 16:57:36 INFO - PROCESS | 2293 | Values: 140.0 174.0 126.0 171.0 162.0 153.0 175.0 181.0 175.0 139.0 16:57:36 INFO - PROCESS | 2293 | 16:57:36 INFO - PROCESS | 2293 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.80 Median:92.50 stddev:12.19 (13.2%) stddev-sans-first:11.51 16:57:36 INFO - PROCESS | 2293 | Values: 68.0 70.0 93.0 95.0 95.0 92.0 96.0 87.0 69.0 73.0 16:57:36 INFO - PROCESS | 2293 | -------- Summary: end -------- 16:57:36 INFO - PROCESS | 2293 | 16:57:37 INFO - TEST-INFO | 2293: exit 0 16:57:37 INFO - TEST-OK | kraken | took 58542ms 16:57:37 INFO - SUITE-END | took 1169s 16:57:38 INFO - Completed test suite (00:19:30) 16:57:38 INFO - Working with test: dromaeo_css 16:57:38 INFO - Generating results file: dromaeo_css 16:57:38 INFO - Working with test: kraken 16:57:38 INFO - Generating results file: kraken 16:57:38 INFO - javascript benchmark 16:57:38 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 16:57:38 INFO - process_Request line: dromaeo_css 7529.83 graph.html#tests=[[72,64,61]] 16:57:38 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:38 INFO - process_Request line: kraken 1576.40 graph.html#tests=[[232,64,61]] 16:57:38 INFO - RETURN: dromaeo_css: 7529.83 16:57:38 INFO - RETURN: kraken: 1576.40 16:57:38 INFO - javascript benchmark 16:57:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2940.529515277555, 3512.701420379268, 3527.9647203527975, 3544.8759293424737, 3579.3378225028373, 5771.480566748992, 5780.682062486561, 5793.681347525884, 5821.010428227206, 5851.824445266643, 5079.949200508003, 5703.914441283374, 5771.624844385123, 5846.21076154719, 5888.293404791431, 5215.035218484583, 5217.921731174036, 5262.631615786897, 5347.759350829222, 5351.518363347298, 5398.2982212312345, 5406.513413792758, 5421.078416669156, 5421.159720243349, 5423.918641220384, 4927.556519913207, 5252.6323157379, 5329.920051199235, 5336.412994570614, 5348.732563371855, 4197.454330936989, 4378.233809083429, 4933.383327084114, 5279.313689220415, 5295.973520132413, 5188.818391356284, 5230.895382092375, 5258.842234732964, 5267.3679158500845, 5297.417284098746, 5685.4883060524335, 5723.456271654228, 5769.336526299488, 5777.277840269966, 5815.651060936315, 6299.149614801989, 6299.905501417483, 6303.432691057781, 6318.968405157991, 6373.362663733589, 6208.689565521751, 6228.408301211378, 6277.372262773686, 6280.089387038899, 6301.275353334379, 5926.140709597084, 5945.137954996501, 5946.672932988728, 5955.702214889238, 5956.106584012389, 6245.500359971283, 6317.842053948688, 6329.177206963065, 6335.303116657164, 6339.6196228225535, 6120.081987701791, 6126.36500017443, 6219.253689557192, 6236.844078898064, 6241.0, 6249.281332646713, 6271.7804876830005, 6290.150829637941, 6298.7795427160745, 6308.621482711052, 6075.0, 6230.190075290274, 6264.37356264379, 6302.779402720883, 6316.431521163117, 6281.466075383643, 6299.464545513682, 6303.558750887486, 6310.1481300024825, 6320.431161195423, 4888.853334399902, 4914.852554423373, 4938.283948827472, 4949.406071271471, 4958.628102892298, 4375.934360984587, 4398.890027749332, 4400.471943366816, 4495.213337665896, 4522.8643140705835, 5688.971555142198, 5739.71301434935, 5748.310202775694, 5752.33848107473, 5753.194552762617, 6215.192025036717, 6271.905921411182, 6277.497800175975, 6292.0, 6299.905501417483, 5721.199032135504, 5741.770329186869, 5767.653940763567, 5775.249217601685, 5822.388649191774, 5417.5395091416885, 5446.673199608036, 5447.673139611636, 5457.808976685797, 5465.808696695596, 6188.257409110935, 6272.153259309935, 6329.0, 6357.618542887441, 6367.458766004756, 5151.871203219949, 6227.06594010902, 6265.091561723433, 6280.937190628035, 6287.46556542699, 6335.936640633535, 6340.461060809698, 6368.076628888878, 6392.840178995376, 6393.104965304768, 6117.583823141572, 6145.371476558805, 6236.532260080421, 6265.997440409513, 6266.154069200599, 6261.342559031418, 6285.811425657238, 6299.118123462627, 6300.054991751274, 6305.936940630535, 5878.500327472042, 6169.784057557964, 6178.69106544662, 6183.165272688309, 6197.5351848610635, 6131.478824299985, 6158.661273629993, 6171.382861713792, 6188.1027251049245, 6205.379462053758, 5088.414832294334, 6001.339852616122, 6033.728482218398, 6063.818085457443, 6118.908216376669, 4963.0, 5372.785088596413, 6208.441240288395, 6211.565190436626, 6271.31015588294, 6120.418560236771, 6124.510039196943, 6128.233970753656, 6135.969320153371, 6163.322034576104], "unit": "score", "name": "dojo.html", "value": 5726.690937587224}, {"lowerIsBetter": false, "replicates": [446.64714875248546, 496.4886167247734, 496.9006198760249, 533.825583715825, 585.3853453873437, 31685.524717129232, 37481.81259093701, 37619.0, 37654.0, 37701.0, 38734.0, 38947.41578876319, 39153.41269880947, 39202.411963820494, 39301.60698393015, 8351.83296334073, 9448.244140468745, 9459.432434053979, 9754.609815607402, 9763.755906102333, 9629.422234665943, 9631.566579503904, 9647.17998970085, 9722.465264410455, 9760.951195244013, 8806.0, 9688.224942004657, 9788.559514821814, 9790.559424825864, 9844.310898237127, 9643.855342169803, 9682.903170968271, 9716.708498745049, 9747.853782193273, 9762.316637835354, 9547.665831695927, 9559.569819358145, 9653.662121825773, 9687.17658998986, 9705.0, 37891.0, 37988.62011379879, 38026.049348766224, 38350.23299533994, 38388.736957358655, 2973.197236746088, 2984.1942675477717, 3247.723943464808, 3315.801051936867, 3568.357695614788, 28805.0, 29074.563881541795, 29176.708232917612, 29238.56142157869, 29253.70746292531, 2812.4796912571037, 2828.4060347327086, 2840.67332256789, 2863.2269287292315, 2939.867705953216, 480748.0, 493136.0, 493362.0, 493551.0, 493759.5312023453, 60221.09668354978, 71198.2880171202, 72031.6398418015, 72443.0, 72765.0, 59099.52251193755, 70650.0, 70729.64635176791, 72053.27946720466, 72300.0, 16148.0, 16482.093484858447, 16532.256048477848, 16665.0, 16782.580435488966, 12390.81413778794, 12692.936535317449, 12716.791904769032, 12831.871681283068, 12921.353932303347, 21757.564848702936, 21957.780422195894, 22488.32535023952, 22540.887295563418, 22546.661800073012, 8454.77405776159, 9861.753456163653, 10079.177830207555, 10107.69676909694, 10110.646127385506, 920.861870719384, 921.4839689773748, 946.9715908522618, 1059.0733108530037, 1062.86182796236, 25827.096051638102, 29557.45310562746, 29565.0, 29867.0, 31608.893688721244, 985.0592683986775, 994.9502524873727, 1009.7475631092227, 1017.7760892603616, 1050.422267752733, 14379.065360751518, 14582.708345833023, 14895.957282990303, 15827.762583561256, 15907.920460397856, 615211.0, 618859.0, 624502.0, 631229.0, 633928.0, 49356.75321623369, 57605.71197143987, 58153.0, 58174.709126454094, 58308.4169158303, 1425.287356321839, 1435.6769726811383, 1451.361400983564, 1461.101422625099, 1560.7736878152605, 30040.549391759578, 30142.0, 30316.0, 30327.69672303337, 30675.539866901567, 49222.75388623034, 49444.258336124265, 49963.75018124886, 50029.49970500248, 50061.49938500714, 347882.0, 411131.0, 412237.0, 412574.93712531246, 413889.93055034534, 32324.515132272565, 34530.65469345274, 44832.551674482835, 44874.551254487036, 44923.550764493244, 35509.82245088861, 40378.39432408458, 40995.590044099175, 41656.791716041225, 42081.0, 34263.0, 34869.302613948086, 35756.28487430289, 35817.283654326246, 36019.639803601625, 34700.74108869601, 34928.47607285842, 35439.29121417506, 35475.290494190485, 35577.46633800443, 34736.82631586927, 34791.9562413128, 34884.30231395307, 36742.8162859184, 37528.62471375251, 30486.390272194876, 31926.36147276995, 32010.0, 32897.0, 33258.334833303685, 25548.361290967874, 25834.61248081318, 26083.668351710014, 26312.8684356577, 27244.863775680995], "unit": "score", "name": "ext.html", "value": 19864.886016568813}, {"lowerIsBetter": false, "replicates": [287.4165444148378, 367.4910249304712, 368.05960770232065, 368.4454895382449, 369.54176820742254, 15310.387584496606, 18764.53088672782, 19403.70894436581, 19546.12042458089, 20798.480037999077, 11510.597129100483, 18876.33932812352, 19044.809551904476, 19124.80875191248, 19213.903930480326, 5196.948030519684, 5302.840914772543, 5305.7877684892555, 5375.516203541681, 5376.0, 5114.43741188469, 5359.598030147735, 5365.222042803791, 5367.490088441611, 5378.838634840961, 3871.322518559255, 5356.437574054727, 5360.865978350534, 5362.597805164609, 5675.489205971462, 5848.883022339572, 5885.4997325227405, 5891.293044834626, 5900.321463031763, 5915.349311575723, 4789.784459699287, 5399.757010934517, 5425.565954723652, 5633.577481688849, 5699.145128230757, 13177.472901083946, 16547.503574892773, 23936.760632393627, 24562.771861407036, 24632.261032169063, 2007.5984803039305, 2182.01809185867, 2278.1798552521077, 2378.797802186816, 2387.236084452976, 9600.32797704161, 9753.561089750978, 12750.362481875869, 13726.245056521888, 13901.88784897216, 1641.3844808196927, 1699.7195462748632, 1727.7494763259258, 1732.7747392838976, 1794.4168145352683, 99680.0, 102458.0, 103248.0, 104309.0, 104560.0, 11196.8803119689, 11328.94335528317, 11330.830037549444, 11337.093032557375, 11380.146489013192, 13536.526221582395, 13593.0, 13626.0, 13641.931790340985, 13644.863551364358, 6306.306306306303, 7761.9611901940125, 8162.83674326522, 8550.358723095793, 8585.613647385882, 8736.912630873738, 8741.475511469333, 8747.256483198998, 8781.121887811169, 8797.868031979526, 3639.8544058237903, 4491.146682130385, 4495.078508905666, 4514.345419914094, 4581.610563102174, 1850.518865095085, 1891.5743957609702, 1905.552195234119, 1912.053533500926, 1915.348781414298, 352.95588051493564, 392.6936989148469, 393.5926316262654, 399.4347997583445, 420.97684627345177, 11706.297622142698, 11882.28706277626, 11949.342786146672, 11955.402229888645, 12098.637040888787, 431.6417373579921, 438.40595992430434, 445.3364486914474, 450.8309383981007, 451.1811062920788, 5387.326584176978, 10594.0, 11174.0, 11175.217734758651, 11175.944120279346, 596327.0, 728903.0, 733417.0, 743352.0, 755167.0, 73798.0, 106039.46980265049, 106465.40301895478, 110694.0, 117648.0, 1121.43928035982, 1167.795635763755, 1170.7307319316606, 1171.1918776044672, 1174.512577280436, 17714.645707086045, 18014.819851801316, 18066.81933180704, 18111.72832407541, 18350.357737479124, 50706.49293507018, 50896.49103508917, 50959.23561146512, 51446.0, 51564.22653660273, 74187.0, 74632.0, 75439.86840197291, 75573.24426755663, 76575.0, 7357.926420735724, 7565.886511702439, 7599.392048635986, 7643.121041080124, 7656.808579785327, 11293.322400655657, 11816.82274765862, 11847.70380740454, 11962.222455540363, 12117.636470905887, 9968.053034961667, 10049.246306526893, 10073.597056117966, 10204.540795664065, 10471.42407167613, 5596.860078497907, 8963.700263461891, 9035.774105647411, 9601.37591056579, 10488.842667359842, 9669.0, 9682.370645907993, 10490.580376784843, 10628.36229826213, 10956.0, 7009.474289428212, 7293.52592081513, 7522.134954480086, 7581.696732130653, 7634.961825190839, 7581.54510729358, 10243.743906402102, 10494.737631558966, 10498.265121441425, 10505.737356565842], "unit": "score", "name": "jquery.html", "value": 8533.177427632138}, {"lowerIsBetter": false, "replicates": [1368.6509939965308, 1521.5815650696059, 1740.860731141508, 1894.6684330242203, 1918.8368988635966, 7989.640466179021, 8711.0, 8787.956060219698, 8960.910390896097, 8968.058353872848, 8694.521801300925, 8787.560621968893, 8849.07084756101, 8899.243564297027, 8900.866487002684, 2493.2021753039035, 2506.7618576235227, 2509.736477669846, 2511.635812807151, 2518.6977562692505, 2456.336789066951, 2510.3598582361565, 2513.170653684289, 2514.5976643737004, 2517.7356377580363, 2196.6595177747477, 2439.7682220189054, 2476.566600844854, 2500.824942254043, 2505.060602274147, 2450.15469662966, 2461.7415171407015, 2471.6292556116728, 2499.8875050622764, 2500.987100224412, 2417.0815090265587, 2503.1614409172766, 2506.323292710958, 2511.7864981476596, 2512.748725127491, 8865.42374745646, 8877.33419993503, 8890.155435233642, 8937.50843703596, 8943.50810705411, 5459.317585301837, 5496.780128794843, 5589.329280486327, 5615.2700148980775, 5636.323641163046, 3621.6016238213774, 3715.4612581175847, 3730.2166545025307, 3751.549814022335, 3779.055236190952, 1050.390773351462, 1067.2049323254225, 1076.2036093290988, 1103.5475455063386, 1105.4141305108305, 12268.938655306667, 12368.567100151451, 12380.947619452358, 12407.193532420453, 12409.93795031019, 4933.186024306021, 5022.8493145204975, 5033.471485494044, 5035.82374616894, 5100.413452452941, 10258.948705256425, 10320.12278956297, 10374.740631484274, 10426.27016108865, 10453.790924181474, 5551.278333816578, 5566.109422492463, 5578.967890940108, 5584.52531534816, 5630.23991761107, 4969.4782047884455, 5073.771680274396, 5090.669106508065, 5106.463821298785, 5112.463191364927, 3811.104390468238, 4044.8584299549375, 4064.7967601619803, 4083.8570650027104, 4114.238865809834, 1226.4419689041465, 1337.806018127366, 1338.3642769684516, 1348.9595312140652, 1362.6252780485247, 1082.9458527073614, 1083.2633809009792, 1118.1390329446444, 1238.8141778733082, 1367.193355920012, 8081.717139900075, 8087.797805054803, 8102.473339232931, 8122.472039317426, 8245.505269683837, 1182.9704257393635, 1195.0917302849896, 1202.0744027099086, 1203.5065623094665, 1228.4533382644638, 6131.591784722373, 6172.506199504029, 6181.196444462191, 6254.093156492283, 6310.432061114522, 10669.35983840972, 10919.563217471372, 11019.504122314514, 11100.94541018602, 11119.221654484109, 10674.412907290018, 10787.083097936764, 10844.186685998582, 10876.782464350668, 10919.617813376493, 8361.289290410261, 8401.495910245405, 8435.831283374298, 8438.240558349655, 8443.746687599381, 6614.768483103261, 7735.651895664596, 7881.172476889844, 7887.290143887078, 7905.762827115196, 8422.873656895028, 9592.23262139041, 9686.75783105428, 9813.803723925339, 9851.704448866545, 9966.003399659976, 10117.392956422638, 10220.897791021995, 10229.74425639365, 10229.74425639365, 7464.552126872405, 7541.47209695338, 7557.05536807899, 7580.31777140038, 7689.154193038649, 8189.918100818915, 8280.544570048705, 8370.748877533684, 8400.831983360176, 8466.788330291793, 6518.2504012037325, 6906.827329316808, 7285.490015698851, 7866.6853325868615, 7953.0, 7578.658960346687, 7643.88534171999, 7654.0, 7698.345640620386, 7771.417143714131, 7872.803179920319, 7875.960620197092, 7877.8818317724135, 7886.802829929068, 7904.723334683258, 6895.931040689529, 7034.859302814018, 7093.290670932865, 7128.643567821485, 7134.179569349383, 7168.2831716827895, 7186.568805871664, 7297.16082650502, 7311.817204569928, 7312.780616581511], "unit": "score", "name": "mootools.html", "value": 5025.909139911386}, {"lowerIsBetter": false, "replicates": [320.94383482890504, 322.02426647258807, 326.6276444852867, 332.9866805327788, 334.29630627529053, 6917.1699396072545, 7024.297570242973, 7047.154341479017, 7067.328603782646, 7142.178649455314, 7117.572945623253, 7120.537165084266, 7122.1453425589, 7127.607981561012, 7127.786166415003, 4305.268104422255, 5192.247124167013, 5229.372475302969, 5231.581473482112, 5248.737563121847, 4225.809838557272, 4864.854054378375, 5195.818146364878, 5256.500632439931, 5261.184516399964, 5032.723200223986, 5033.84898453047, 5035.446100928895, 5042.899142017158, 5061.392632884059, 5039.269305950635, 5046.646734728571, 5060.114479966028, 5062.1900495920845, 5072.2391641253735, 4255.957440425587, 4272.974486123308, 4282.743035417885, 4284.507281662618, 4288.078063216423, 6529.706163222666, 6704.798856034278, 6708.4968627352655, 6712.664366781691, 6783.389494945479, 5908.67502287374, 5918.644881307136, 5922.644641321534, 5929.436703513159, 5943.227380440515, 7420.628968551551, 7426.220246874054, 7431.702731890718, 7432.0, 7437.3306402423505, 4489.506154323022, 4618.145643056046, 4698.389209402756, 4725.3384526166365, 4760.928586071212, 7759.107702614215, 7830.647620857075, 7896.210378962115, 7915.841683166362, 7936.2063793620755, 3957.2283404736377, 4800.279958006327, 4801.663883528119, 4809.134355815987, 4817.662763606514, 4804.975975120172, 4900.240462728283, 4900.534449227318, 4909.4354149273295, 4909.7790599423115, 5908.822735317947, 5919.378465261086, 5928.4960778334325, 5933.821985340447, 5935.169076329317, 7464.962675186589, 7465.402767778564, 7469.9253007470315, 7485.401167906554, 7499.287567681062, 1652.8512433880767, 1679.5717092141426, 1701.8723595730369, 1702.8041775195763, 1704.9573760656083, 837.8031162676766, 921.5484412637893, 967.1295833749682, 1063.6170978447753, 1084.5607528950788, 5552.833414997475, 5937.851553711105, 6512.283648798629, 6859.485538584527, 6906.136732908387, 6541.247756507967, 7414.925850741532, 7496.137944136385, 7770.45606807518, 7773.766786996399, 6702.19573651165, 6859.485538584626, 6873.690683919235, 6904.516683832084, 6935.029095926574, 4116.156187981456, 4128.525219599785, 4135.483064616923, 4140.213359461693, 4145.875623731293, 8050.838983220303, 8080.878786818203, 8101.797455063553, 8103.3112185463715, 8107.918920810835, 7795.376369890395, 8016.238457346542, 8028.835818806358, 8036.598170091472, 8054.194580541899, 8069.193080691884, 8074.273315401642, 8080.353571714249, 8088.959555202304, 8097.595120243965, 7553.773386798405, 7712.0, 7746.264104910025, 7746.65140068687, 7901.881471778043, 7694.846103078019, 7725.49784264021, 7735.381169506539, 7745.0, 7748.302652761278, 7982.720604778805, 8189.22202390772, 8221.79445513867, 8226.218509241613, 8227.095019547965, 4868.488808675038, 4873.756312184306, 4874.756262186947, 4882.584980276716, 4894.926576101432, 7876.0, 7900.881486777588, 7922.603869806371, 7927.563983980936, 7963.243491868263, 7402.481826272109, 7541.5475071495885, 7560.0, 7572.583507907118, 7608.01095857535, 6077.6353418795015, 6466.482681385572, 7529.774106776806, 7545.283198096172, 7557.168711441847, 7361.484696071224, 7365.484416091036, 7375.409967202718, 7393.963030184815, 7398.889016664647, 7389.482736208413, 7561.09266887977, 7566.546007239584, 7580.3556697681315, 7593.848123037398, 7369.410447164107, 7395.7041718330665, 7398.371138453292, 7414.740484083031, 7418.443616728875], "unit": "score", "name": "prototype.html", "value": 5397.892354892101}, {"lowerIsBetter": false, "replicates": [702.8313204830843, 705.8059033765713, 744.4639859301301, 748.8689479341114, 752.5973604121796, 14795.926020369896, 15070.0, 15170.013949093314, 15180.772288415683, 15198.240087995597, 14106.29468526572, 14220.928895355535, 14305.570832875004, 14343.713125737479, 14355.56933292003, 712.4763298975249, 858.8153546987396, 859.9656013759442, 873.6723728601775, 890.536920801183, 870.4385671242045, 886.1979908183105, 891.754767438953, 893.0622846011662, 893.2675206330812, 771.8803585444265, 899.4153800029967, 924.8011677489338, 937.4703292639637, 938.6902322233681, 882.8896387951506, 899.5412339706731, 912.8813254276902, 925.7361651929201, 927.9860802087974, 677.8203775999364, 684.9657517124124, 686.6772616870063, 691.0, 692.2834865913806, 14808.703825923421, 14977.400903963828, 15048.097114173184, 15090.698186036218, 15137.318820653098, 10603.734906627318, 11207.775844483065, 11788.880056394628, 12112.0, 12281.078919081105, 9162.496062716547, 10508.527116279785, 10678.946605267001, 10720.46397680113, 11375.943120284346, 3424.880129195491, 3479.3911065563425, 3550.0237434705405, 3565.322588708137, 3713.461548075541, 77256.22743772547, 79486.80769788516, 79636.60181699113, 80868.59565702193, 82692.0, 8222.753317400488, 8241.175882411711, 9519.381240219502, 9526.142647161789, 9807.019298070278, 20522.076506556943, 20595.382138535868, 20792.688109678365, 20825.166993320097, 20861.58276834455, 7468.589227592426, 7580.54516728998, 7581.50720203185, 7726.690932362755, 7761.0298712660915, 4211.684123690736, 4222.265486548949, 4227.154569086134, 4274.572542745763, 4286.271333873249, 3576.0, 3597.8380972856285, 3612.0789198754674, 3638.181409182913, 3638.927221455609, 663.5222639699409, 668.1280928388403, 670.3564578005072, 680.0988689985788, 680.2619158213394, 537.1942086869695, 545.9727013649301, 573.2146958666654, 602.9698515074228, 604.2959951656271, 8272.917270827214, 8801.075887031897, 9097.272218222526, 9176.595234287446, 9350.392224505522, 498.4566822163786, 519.8752299448105, 592.7569696424531, 601.1313651773233, 665.0921492163162, 3906.140649057203, 4026.3960405938756, 4033.6773058155277, 4051.1897620476025, 4118.345083413931, 90778.09221907829, 92796.0, 96114.0388596119, 97736.0, 97923.0, 82905.58547207226, 84014.5799271012, 84017.15982840094, 84879.0, 85214.0, 68716.96924546135, 70920.0, 71775.6411217951, 72051.63974180096, 74695.62652186705, 8478.152184781718, 8784.516851573226, 8874.0, 8923.286137108886, 8957.462552246887, 50491.0, 50731.0, 51133.744331279595, 51194.23208651948, 52292.954140916205, 63380.0, 64322.67838660964, 66486.00270995843, 66535.33464665485, 66584.33539161365, 10911.836322455329, 11145.2198346115, 11269.98900076159, 11471.942640286745, 11817.172797904064, 12140.33228172459, 12229.816552751538, 12354.938225309175, 12414.81377779352, 12475.688107797378, 11189.664310070386, 11291.548338066385, 11431.714207144887, 11678.182527223013, 11718.88281117178, 9478.086416672357, 10349.63776267827, 11588.130890183102, 11710.824337635113, 12118.151729378858, 9039.864402034107, 11117.110631149328, 11253.831192531954, 11350.205485616258, 11780.646580602595, 9084.63661453561, 9196.770080748034, 9285.303602229726, 9391.671291504765, 9568.90431095708, 9161.86257206129, 9267.0, 9892.406455612687, 10004.26177190599, 10020.949895250476], "unit": "score", "name": "yui.html", "value": 6920.511857054788}], "name": "dromaeo_css", "value": 7529.826502653537}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 111.0, 114.0, 115.0, 115.0, 127.0, 114.0, 114.0, 116.0, 112.0], "unit": "score", "name": "ai-astar", "value": 115.4}, {"lowerIsBetter": true, "replicates": [154.0, 123.0, 145.0, 152.0, 118.0, 165.0, 142.0, 120.0, 156.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 139.6}, {"lowerIsBetter": true, "replicates": [195.0, 269.0, 236.0, 206.0, 214.0, 237.0, 261.0, 273.0, 199.0, 201.0], "unit": "score", "name": "audio-dft", "value": 229.1}, {"lowerIsBetter": true, "replicates": [73.0, 90.0, 101.0, 142.0, 48.0, 67.0, 83.0, 91.0, 135.0, 59.0], "unit": "score", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [83.0, 90.0, 150.0, 62.0, 112.0, 67.0, 114.0, 106.0, 116.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [86.0, 93.0, 121.0, 137.0, 112.0, 92.0, 126.0, 104.0, 86.0, 95.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 105.2}, {"lowerIsBetter": true, "replicates": [95.0, 117.0, 122.0, 96.0, 97.0, 94.0, 96.0, 95.0, 95.0, 114.0], "unit": "score", "name": "imaging-darkroom", "value": 102.1}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 91.0, 91.0, 101.0, 92.0, 91.0, 95.0, 93.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 93.3}, {"lowerIsBetter": true, "replicates": [51.0, 61.0, 55.0, 54.0, 57.0, 55.0, 57.0, 61.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 75.0, 72.0, 66.0, 74.0, 91.0, 97.0, 97.0, 88.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 78.6}, {"lowerIsBetter": true, "replicates": [99.0, 108.0, 86.0, 83.0, 96.0, 104.0, 110.0, 84.0, 87.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 94.1}, {"lowerIsBetter": true, "replicates": [129.0, 121.0, 136.0, 110.0, 121.0, 125.0, 110.0, 136.0, 138.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [140.0, 174.0, 126.0, 171.0, 162.0, 153.0, 175.0, 181.0, 175.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 159.6}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 93.0, 95.0, 95.0, 92.0, 96.0, 87.0, 69.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 83.8}], "name": "kraken", "value": 1576.3999999999996}]} 16:57:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1576.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7529.83"}}} 16:57:38 INFO - Return code: 0 16:57:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:57:38 ERROR - # TBPL SUCCESS # 16:57:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:57:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:57:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:57:38 INFO - 2016-02-16 16:57:38.234 screenresolution[2298:28320] starting screenresolution argv=screenresolution get 16:57:38 INFO - 2016-02-16 16:57:38.237 screenresolution[2298:28320] Display 0: 1600x1200x32@60 16:57:38 INFO - 2016-02-16 16:57:38.243 screenresolution[2299:28323] starting screenresolution argv=screenresolution list 16:57:38 INFO - Available Modes on Display 0 16:57:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:57:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:57:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:57:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:57:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:57:38 INFO - Intel Iris: 16:57:38 INFO - Chipset Model: Intel Iris 16:57:38 INFO - Type: GPU 16:57:38 INFO - Bus: Built-In 16:57:38 INFO - VRAM (Dynamic, Max): 1536 MB 16:57:38 INFO - Vendor: Intel (0x8086) 16:57:38 INFO - Device ID: 0x0a2e 16:57:38 INFO - Revision ID: 0x0009 16:57:38 INFO - Displays: 16:57:38 INFO - Display: 16:57:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:57:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:57:38 INFO - Display Serial Number: 1600x1200 60 16:57:38 INFO - Main Display: Yes 16:57:38 INFO - Mirror: Off 16:57:38 INFO - Online: Yes 16:57:38 INFO - Rotation: Supported 16:57:38 INFO - Return code: 0 16:57:38 INFO - Running post-action listener: _resource_record_post_action 16:57:38 INFO - Running post-run listener: _resource_record_post_run 16:57:39 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 2506752; Write bytes: 710927360; Read time: 39; Write time: 2012 16:57:39 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 404570624; Write bytes: 405751296; Read time: 30117; Write time: 695 16:57:39 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 2506752; Write bytes: 303052800; Read time: 39; Write time: 1281 16:57:39 INFO - Running post-run listener: _upload_blobber_files 16:57:39 INFO - Blob upload gear active. 16:57:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:57:39 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 16:57:39 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'] 16:57:39 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 16:57:39 INFO - (blobuploader) - INFO - Open directory for files ... 16:57:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:57:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:57:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:41 INFO - (blobuploader) - INFO - Done attempting. 16:57:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:57:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:57:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:42 INFO - (blobuploader) - INFO - Done attempting. 16:57:42 INFO - (blobuploader) - INFO - Iteration through files over. 16:57:42 INFO - Return code: 0 16:57:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:57:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:57:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56b3f8a7a471736e9566355bc10fd76283d63a70d1eb15fcd50d43fae7e9399116157cb070745871092332e90311417829408aa9651cf29557931693e3231466", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d5b4f4f5fb0407aaf1b93f4d277bfe370b5ef4c907dd1189295620a9b8b7baa66d553225986ce2cd2cac97c1cb4c567da3832f18a6c95dc5d04820c1259101c"} 16:57:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:57:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:57:42 INFO - Contents: 16:57:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56b3f8a7a471736e9566355bc10fd76283d63a70d1eb15fcd50d43fae7e9399116157cb070745871092332e90311417829408aa9651cf29557931693e3231466", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d5b4f4f5fb0407aaf1b93f4d277bfe370b5ef4c907dd1189295620a9b8b7baa66d553225986ce2cd2cac97c1cb4c567da3832f18a6c95dc5d04820c1259101c"} 16:57:42 INFO - Running post-run listener: copy_logs_to_upload_dir 16:57:42 INFO - Copying logs to upload dir... 16:57:42 INFO - mkdir: /builds/slave/test/build/upload/logs 16:57:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.858741 ========= master_lag: 0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-02-16 16:57:42.407847) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 16:57:42.409171) ========= 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.MrKBKjFLks/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.1SuNbQVHht/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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/56b3f8a7a471736e9566355bc10fd76283d63a70d1eb15fcd50d43fae7e9399116157cb070745871092332e90311417829408aa9651cf29557931693e3231466", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d5b4f4f5fb0407aaf1b93f4d277bfe370b5ef4c907dd1189295620a9b8b7baa66d553225986ce2cd2cac97c1cb4c567da3832f18a6c95dc5d04820c1259101c"} build_url:https://queue.taskcluster.net/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/OJTh38RUQ9ilONe-kAKTNw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56b3f8a7a471736e9566355bc10fd76283d63a70d1eb15fcd50d43fae7e9399116157cb070745871092332e90311417829408aa9651cf29557931693e3231466", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d5b4f4f5fb0407aaf1b93f4d277bfe370b5ef4c907dd1189295620a9b8b7baa66d553225986ce2cd2cac97c1cb4c567da3832f18a6c95dc5d04820c1259101c"}' ========= master_lag: 0.90 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 16:57:43.321251) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-02-16 16:57:43.321590) ========= 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.MrKBKjFLks/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.1SuNbQVHht/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.005146 ========= master_lag: 3.54 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-02-16 16:57:46.862759) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 16:57:46.866144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 16:57:46.875966) ========= ========= Total master_lag: 7.36 =========