builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0025 starttime: 1455674971.22 results: success (0) buildid: 20160216163450 builduid: 468cace76a2e46878740429ddc7ac500 revision: bf152107a11d801dec09449aa24140bd4d9f518e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:31.215996) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:31.216382) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:31.216675) ========= 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.F1LZwrMbJz/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.47Es9zfbWG/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.005799 basedir: '/builds/slave/test' ========= master_lag: 0.85 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:32.071338) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:32.074737) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:32.491625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:32.491922) ========= 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.F1LZwrMbJz/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.47Es9zfbWG/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.005270 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:32.537722) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:32.538054) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:32.538404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:32.541751) ========= 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.F1LZwrMbJz/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.47Es9zfbWG/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 18:09:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 190M=0s 2016-02-16 18:09:33 (190 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.602882 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:33.187941) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:33.188240) ========= 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.F1LZwrMbJz/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.47Es9zfbWG/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.019318 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:33.259328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:33.263710) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bf152107a11d801dec09449aa24140bd4d9f518e --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 bf152107a11d801dec09449aa24140bd4d9f518e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F1LZwrMbJz/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.47Es9zfbWG/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 18:09:33,302 truncating revision to first 12 chars 2016-02-16 18:09:33,302 Setting DEBUG logging. 2016-02-16 18:09:33,302 attempt 1/10 2016-02-16 18:09:33,302 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bf152107a11d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-16 18:09:33,930 unpacking tar archive at: fx-team-bf152107a11d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.873092 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:34.177307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:34.183730) ========= echo bf152107a11d801dec09449aa24140bd4d9f518e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bf152107a11d801dec09449aa24140bd4d9f518e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F1LZwrMbJz/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.47Es9zfbWG/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 bf152107a11d801dec09449aa24140bd4d9f518e program finished with exit code 0 elapsedTime=0.004909 script_repo_revision: 'bf152107a11d801dec09449aa24140bd4d9f518e' ========= master_lag: 0.09 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:34.281113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:34.281451) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 18:09:34.388449) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-16 18:09:34.394867) ========= /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.F1LZwrMbJz/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.47Es9zfbWG/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 18:09:34 INFO - MultiFileLogger online at 20160216 18:09:34 in /builds/slave/test 18:09:34 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 18:09:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:09:34 INFO - {'append_to_log': False, 18:09:34 INFO - 'base_work_dir': '/builds/slave/test', 18:09:34 INFO - 'blob_upload_branch': 'Fx-Team', 18:09:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:09:34 INFO - 'branch': 'Fx-Team', 18:09:34 INFO - 'buildbot_json_path': 'buildprops.json', 18:09:34 INFO - 'config_files': ('talos/mac_config.py',), 18:09:34 INFO - 'default_actions': ('clobber', 18:09:34 INFO - 'read-buildbot-config', 18:09:34 INFO - 'download-and-extract', 18:09:34 INFO - 'populate-webroot', 18:09:34 INFO - 'create-virtualenv', 18:09:34 INFO - 'install', 18:09:34 INFO - 'run-tests'), 18:09:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:09:34 INFO - 'download_minidump_stackwalk': True, 18:09:34 INFO - 'download_symbols': 'ondemand', 18:09:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:09:34 INFO - 'tooltool.py': '/tools/tooltool.py', 18:09:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:09:34 INFO - '/tools/misc-python/virtualenv.py')}, 18:09:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:09:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:09:34 INFO - 'installer_path': 'installer.exe', 18:09:34 INFO - 'log_level': 'info', 18:09:34 INFO - 'log_name': 'talos', 18:09:34 INFO - 'log_to_console': True, 18:09:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:09:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:09:34 INFO - 'opt_config_files': (), 18:09:34 INFO - 'pip_index': False, 18:09:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:09:34 INFO - 'cmd': ('bash', 18:09:34 INFO - '-c', 18:09:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:09:34 INFO - 'enabled': True, 18:09:34 INFO - 'halt_on_failure': False, 18:09:34 INFO - 'name': 'check_screen_resolution'},), 18:09:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:09:34 INFO - 'cmd': ('bash', 18:09:34 INFO - '-c', 18:09:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:09:34 INFO - 'enabled': True, 18:09:34 INFO - 'halt_on_failure': False, 18:09:34 INFO - 'name': 'check_screen_resolution'},), 18:09:34 INFO - 'run_cmd_checks_enabled': True, 18:09:34 INFO - 'sps_profile': False, 18:09:34 INFO - 'sps_profile_interval': 0, 18:09:34 INFO - 'suite': 'dromaeojs-e10s', 18:09:34 INFO - 'system_bits': '32', 18:09:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:09:34 INFO - 'title': 't-yosemite-r7-0025', 18:09:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:09:34 INFO - 'use_talos_json': True, 18:09:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:09:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:09:34 INFO - 'work_dir': 'build'} 18:09:34 INFO - ##### 18:09:34 INFO - ##### Running clobber step. 18:09:34 INFO - ##### 18:09:34 INFO - Running pre-action listener: _resource_record_pre_action 18:09:34 INFO - Running main action method: clobber 18:09:34 INFO - rmtree: /builds/slave/test/build 18:09:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:09:35 INFO - Running post-action listener: _resource_record_post_action 18:09:35 INFO - ##### 18:09:35 INFO - ##### Running read-buildbot-config step. 18:09:35 INFO - ##### 18:09:35 INFO - Running pre-action listener: _resource_record_pre_action 18:09:35 INFO - Running main action method: read_buildbot_config 18:09:35 INFO - Using buildbot properties: 18:09:35 INFO - { 18:09:35 INFO - "project": "", 18:09:35 INFO - "product": "firefox", 18:09:35 INFO - "script_repo_revision": "production", 18:09:35 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 18:09:35 INFO - "repository": "", 18:09:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 18:09:35 INFO - "buildid": "20160216163450", 18:09:35 INFO - "pgo_build": "False", 18:09:35 INFO - "basedir": "/builds/slave/test", 18:09:35 INFO - "buildnumber": 374, 18:09:35 INFO - "slavename": "t-yosemite-r7-0025", 18:09:35 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:09:35 INFO - "platform": "yosemite_r7", 18:09:35 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:09:35 INFO - "branch": "fx-team", 18:09:35 INFO - "repo_path": "integration/fx-team", 18:09:35 INFO - "revision": "bf152107a11d801dec09449aa24140bd4d9f518e", 18:09:35 INFO - "stage_platform": "macosx64", 18:09:35 INFO - "builduid": "468cace76a2e46878740429ddc7ac500", 18:09:35 INFO - "slavebuilddir": "test" 18:09:35 INFO - } 18:09:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 18:09:35 INFO - Running post-action listener: _resource_record_post_action 18:09:35 INFO - ##### 18:09:35 INFO - ##### Running download-and-extract step. 18:09:35 INFO - ##### 18:09:35 INFO - Running pre-action listener: _resource_record_pre_action 18:09:35 INFO - Running main action method: download_and_extract 18:09:35 INFO - mkdir: /builds/slave/test/build/tests 18:09:35 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')]} 18:09:35 INFO - https://queue.taskcluster.net/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:09:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/test_packages.json 18:09:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/test_packages.json 18:09:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:09:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:09:37 INFO - Downloaded 1277 bytes. 18:09:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:09:37 INFO - Using the following test package requirements: 18:09:37 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:09:37 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 18:09:37 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 18:09:37 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:09:37 INFO - u'jsshell-mac.zip'], 18:09:37 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 18:09:37 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:09:37 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 18:09:37 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 18:09:37 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 18:09:37 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:09:37 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 18:09:37 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:09:37 INFO - https://queue.taskcluster.net/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:09:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:09:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:09:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/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 18:09:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/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 18:09:38 INFO - Downloaded 17803563 bytes. 18:09:38 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'] 18:09:38 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 18:09:41 INFO - Return code: 0 18:09:41 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 18:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:09:41 INFO - https://queue.taskcluster.net/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:09:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:09:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:09:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/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 18:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/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 18:09:42 INFO - Downloaded 17803563 bytes. 18:09:42 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'] 18:09:42 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 18:09:46 INFO - Return code: 0 18:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:09:46 INFO - https://queue.taskcluster.net/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:09:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:09:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:09:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/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 18:09:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/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 18:09:47 INFO - Downloaded 10707071 bytes. 18:09:47 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'] 18:09:47 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 18:09:47 INFO - Return code: 0 18:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:09:47 INFO - https://queue.taskcluster.net/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:09:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:09:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:09:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 18:09:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGW6ooI7SO-uoVIO_IdkXg/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 18:09:53 INFO - Downloaded 111183667 bytes. 18:09:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:09:53 INFO - mkdir: /builds/slave/test/properties 18:09:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:09:53 INFO - Writing to file /builds/slave/test/properties/build_url 18:09:53 INFO - Contents: 18:09:53 INFO - build_url:https://queue.taskcluster.net/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:09:54 INFO - Running post-action listener: _resource_record_post_action 18:09:54 INFO - Running post-action listener: set_extra_try_arguments 18:09:54 INFO - ##### 18:09:54 INFO - ##### Running populate-webroot step. 18:09:54 INFO - ##### 18:09:54 INFO - Running pre-action listener: _resource_record_pre_action 18:09:54 INFO - Running main action method: populate_webroot 18:09:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:09:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:09:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:09:54 INFO - '--tppagecycles', 18:09:54 INFO - '7'], 18:09:54 INFO - 'tests': ['tsvgm']}}, 18:09:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:09:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:09:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:09:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:09:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:09:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:09:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:54 INFO - 'talos_options': ['--e10s'], 18:09:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:54 INFO - 'tests': ['damp', 'tps']}, 18:09:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:54 INFO - 'talos_options': ['--e10s'], 18:09:54 INFO - 'tests': ['damp', 'tps']}, 18:09:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:09:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:09:54 INFO - 'other': {'tests': ['a11yr', 18:09:54 INFO - 'ts_paint', 18:09:54 INFO - 'tpaint', 18:09:54 INFO - 'sessionrestore', 18:09:54 INFO - 'sessionrestore_no_auto_restore']}, 18:09:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:09:54 INFO - 'tests': ['a11yr', 18:09:54 INFO - 'ts_paint', 18:09:54 INFO - 'tpaint', 18:09:54 INFO - 'sessionrestore', 18:09:54 INFO - 'sessionrestore_no_auto_restore']}, 18:09:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:09:54 INFO - 'tests': ['a11yr', 18:09:54 INFO - 'ts_paint', 18:09:54 INFO - 'tpaint', 18:09:54 INFO - 'sessionrestore', 18:09:54 INFO - 'sessionrestore_no_auto_restore']}, 18:09:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:09:54 INFO - 'tests': ['a11yr', 18:09:54 INFO - 'ts_paint', 18:09:54 INFO - 'tpaint', 18:09:54 INFO - 'sessionrestore', 18:09:54 INFO - 'sessionrestore_no_auto_restore']}, 18:09:54 INFO - 'other_l64': {'tests': ['a11yr', 18:09:54 INFO - 'ts_paint', 18:09:54 INFO - 'tpaint', 18:09:54 INFO - 'sessionrestore', 18:09:54 INFO - 'sessionrestore_no_auto_restore']}, 18:09:54 INFO - 'other_nol64': {'tests': ['a11yr', 18:09:54 INFO - 'ts_paint', 18:09:54 INFO - 'tpaint', 18:09:54 INFO - 'sessionrestore', 18:09:54 INFO - 'sessionrestore_no_auto_restore']}, 18:09:54 INFO - 'svgr': {'tests': ['tsvgx', 18:09:54 INFO - 'tsvgr_opacity', 18:09:54 INFO - 'tart', 18:09:54 INFO - 'tscrollx', 18:09:54 INFO - 'cart']}, 18:09:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:09:54 INFO - 'tests': ['tsvgx', 18:09:54 INFO - 'tsvgr_opacity', 18:09:54 INFO - 'tart', 18:09:54 INFO - 'tscrollx', 18:09:54 INFO - 'cart']}, 18:09:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:54 INFO - 'tests': ['tp5o']}, 18:09:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:54 INFO - 'talos_options': ['--e10s'], 18:09:54 INFO - 'tests': ['tp5o']}, 18:09:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:54 INFO - 'talos_options': ['--xperf_path', 18:09:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:54 INFO - 'tests': ['tp5n']}, 18:09:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:54 INFO - 'talos_options': ['--e10s', 18:09:54 INFO - '--xperf_path', 18:09:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:54 INFO - 'tests': ['tp5n']}}, 18:09:54 INFO - 'talos.zip': {'path': '', 18:09:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:09:54 INFO - Running post-action listener: _resource_record_post_action 18:09:54 INFO - ##### 18:09:54 INFO - ##### Running create-virtualenv step. 18:09:54 INFO - ##### 18:09:54 INFO - Running pre-action listener: _resource_record_pre_action 18:09:54 INFO - Running main action method: create_virtualenv 18:09:54 INFO - Creating virtualenv /builds/slave/test/build/venv 18:09:54 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 18:09:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:09:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:09:54 INFO - Using real prefix '/tools/python27' 18:09:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:09:55 INFO - Installing distribute.............................................................................................................................................................................................done. 18:09:58 INFO - Installing pip.................done. 18:09:58 INFO - Return code: 0 18:09:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103b5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b624c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab84d2a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ffd30>, '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 0x103823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039f6b20>, '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.F1LZwrMbJz/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.47Es9zfbWG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 18:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:09:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1LZwrMbJz/Render', 18:09:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:58 INFO - 'HOME': '/Users/cltbld', 18:09:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:58 INFO - 'LOGNAME': 'cltbld', 18:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:58 INFO - 'MOZ_NO_REMOTE': '1', 18:09:58 INFO - 'NO_EM_RESTART': '1', 18:09:58 INFO - 'PAGER': '/bin/cat', 18:09:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:58 INFO - 'PWD': '/builds/slave/test', 18:09:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:58 INFO - 'SHELL': '/bin/bash', 18:09:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.47Es9zfbWG/Listeners', 18:09:58 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 18:09:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:58 INFO - 'USER': 'cltbld', 18:09:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:58 INFO - 'XPC_FLAGS': '0x0', 18:09:58 INFO - 'XPC_SERVICE_NAME': '0', 18:09:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:58 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 18:09:58 INFO - Cleaning up... 18:09:58 INFO - Return code: 0 18:09:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103b5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b624c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab84d2a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ffd30>, '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 0x103823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039f6b20>, '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.F1LZwrMbJz/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.47Es9zfbWG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 18:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:09:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1LZwrMbJz/Render', 18:09:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:58 INFO - 'HOME': '/Users/cltbld', 18:09:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:58 INFO - 'LOGNAME': 'cltbld', 18:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:58 INFO - 'MOZ_NO_REMOTE': '1', 18:09:58 INFO - 'NO_EM_RESTART': '1', 18:09:58 INFO - 'PAGER': '/bin/cat', 18:09:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:58 INFO - 'PWD': '/builds/slave/test', 18:09:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:58 INFO - 'SHELL': '/bin/bash', 18:09:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.47Es9zfbWG/Listeners', 18:09:58 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 18:09:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:58 INFO - 'USER': 'cltbld', 18:09:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:58 INFO - 'XPC_FLAGS': '0x0', 18:09:58 INFO - 'XPC_SERVICE_NAME': '0', 18:09:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:58 INFO - Downloading/unpacking psutil>=0.7.1 18:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:10:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:10:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:10:01 INFO - Installing collected packages: psutil 18:10:01 INFO - Running setup.py install for psutil 18:10:01 INFO - building 'psutil._psutil_osx' extension 18:10:01 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 18:10:02 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 18:10:02 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 18:10:02 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 18:10:02 INFO - building 'psutil._psutil_posix' extension 18:10:02 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 18:10:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:10:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:10:02 INFO - ^ 18:10:02 INFO - 1 warning generated. 18:10:02 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 18:10:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:10:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:10:02 INFO - Successfully installed psutil 18:10:02 INFO - Cleaning up... 18:10:02 INFO - Return code: 0 18:10:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:10: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')]} 18:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10: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')]} 18:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10: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', '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 0x103b5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b624c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab84d2a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ffd30>, '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 0x103823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039f6b20>, '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.F1LZwrMbJz/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.47Es9zfbWG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 18:10: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:10: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 mozsystemmonitor==0.0.0 18:10:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1LZwrMbJz/Render', 18:10:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:02 INFO - 'HOME': '/Users/cltbld', 18:10:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:02 INFO - 'LOGNAME': 'cltbld', 18:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:02 INFO - 'MOZ_NO_REMOTE': '1', 18:10:02 INFO - 'NO_EM_RESTART': '1', 18:10:02 INFO - 'PAGER': '/bin/cat', 18:10:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:02 INFO - 'PWD': '/builds/slave/test', 18:10:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:02 INFO - 'SHELL': '/bin/bash', 18:10:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.47Es9zfbWG/Listeners', 18:10:02 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 18:10:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:02 INFO - 'USER': 'cltbld', 18:10:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:02 INFO - 'XPC_FLAGS': '0x0', 18:10:02 INFO - 'XPC_SERVICE_NAME': '0', 18:10:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10: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 18:10: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 18:10: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 18:10: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 18:10: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 18:10:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:10:05 INFO - Installing collected packages: mozsystemmonitor 18:10:05 INFO - Running setup.py install for mozsystemmonitor 18:10:05 INFO - Successfully installed mozsystemmonitor 18:10:05 INFO - Cleaning up... 18:10:05 INFO - Return code: 0 18:10:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:10:05 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')]} 18:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:05 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')]} 18:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:05 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 0x103b5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b624c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab84d2a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ffd30>, '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 0x103823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039f6b20>, '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.F1LZwrMbJz/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.47Es9zfbWG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 18:10:05 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 18:10:05 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 18:10:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1LZwrMbJz/Render', 18:10:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:05 INFO - 'HOME': '/Users/cltbld', 18:10:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:05 INFO - 'LOGNAME': 'cltbld', 18:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:05 INFO - 'MOZ_NO_REMOTE': '1', 18:10:05 INFO - 'NO_EM_RESTART': '1', 18:10:05 INFO - 'PAGER': '/bin/cat', 18:10:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:05 INFO - 'PWD': '/builds/slave/test', 18:10:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:05 INFO - 'SHELL': '/bin/bash', 18:10:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.47Es9zfbWG/Listeners', 18:10:05 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 18:10:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:05 INFO - 'USER': 'cltbld', 18:10:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:05 INFO - 'XPC_FLAGS': '0x0', 18:10:05 INFO - 'XPC_SERVICE_NAME': '0', 18:10:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:05 INFO - Downloading/unpacking blobuploader==1.2.4 18:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:08 INFO - Downloading blobuploader-1.2.4.tar.gz 18:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:10:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:10:08 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 18:10:08 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 18:10:08 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 18:10:08 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 18:10:08 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 18:10:08 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 18:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:10:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:10:08 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 18:10:08 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 18:10:08 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 18:10:08 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 18:10:08 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 18:10:08 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 18:10:09 INFO - Downloading docopt-0.6.1.tar.gz 18:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:10:09 INFO - Installing collected packages: blobuploader, requests, docopt 18:10:09 INFO - Running setup.py install for blobuploader 18:10:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:10:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:10:09 INFO - Running setup.py install for requests 18:10:10 INFO - Running setup.py install for docopt 18:10:10 INFO - Successfully installed blobuploader requests docopt 18:10:10 INFO - Cleaning up... 18:10:10 INFO - Return code: 0 18:10:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10:10 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')]} 18:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:10 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')]} 18:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:10 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 0x103b5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b624c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab84d2a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ffd30>, '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 0x103823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039f6b20>, '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.F1LZwrMbJz/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.47Es9zfbWG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 18:10:10 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 18:10:10 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 18:10:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1LZwrMbJz/Render', 18:10:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:10 INFO - 'HOME': '/Users/cltbld', 18:10:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:10 INFO - 'LOGNAME': 'cltbld', 18:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:10 INFO - 'MOZ_NO_REMOTE': '1', 18:10:10 INFO - 'NO_EM_RESTART': '1', 18:10:10 INFO - 'PAGER': '/bin/cat', 18:10:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:10 INFO - 'PWD': '/builds/slave/test', 18:10:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:10 INFO - 'SHELL': '/bin/bash', 18:10:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.47Es9zfbWG/Listeners', 18:10:10 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 18:10:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:10 INFO - 'USER': 'cltbld', 18:10:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:10 INFO - 'XPC_FLAGS': '0x0', 18:10:10 INFO - 'XPC_SERVICE_NAME': '0', 18:10:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:10:10 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-I9V_kG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:10:10 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-CowByL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:10:10 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-EnLTp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:10:10 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-bXFlTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:10:10 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-DDcTmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:10:11 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-xReIWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:10:11 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-iRMOsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:10:11 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Ub8hQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:10:11 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-7D8n7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:10:11 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-PPmCV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:10:11 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-WGZVZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:10:11 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-evodlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:10:11 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-5kRfLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:10:11 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-InmRhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:11 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-iLG7UG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:10:12 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-ggOr4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:10:12 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-fRCHG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:10:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:10:12 INFO - Running setup.py install for manifestparser 18:10:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:10:12 INFO - Running setup.py install for mozcrash 18:10:12 INFO - Running setup.py install for mozdebug 18:10:12 INFO - Running setup.py install for mozdevice 18:10:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:10:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:10:12 INFO - Running setup.py install for mozfile 18:10:13 INFO - Running setup.py install for mozhttpd 18:10:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:10:13 INFO - Running setup.py install for mozinfo 18:10:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:10:13 INFO - Running setup.py install for mozInstall 18:10:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:10:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:10:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:10:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:10:13 INFO - Running setup.py install for mozleak 18:10:13 INFO - Running setup.py install for mozlog 18:10:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:10:13 INFO - Running setup.py install for moznetwork 18:10:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:10:13 INFO - Running setup.py install for mozprocess 18:10:14 INFO - Running setup.py install for mozprofile 18:10:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:10:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:10:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:10:14 INFO - Running setup.py install for mozrunner 18:10:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:10:14 INFO - Running setup.py install for mozscreenshot 18:10:14 INFO - Running setup.py install for moztest 18:10:14 INFO - Running setup.py install for mozversion 18:10:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:10:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:10:14 INFO - Cleaning up... 18:10:14 INFO - Return code: 0 18:10:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10: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')]} 18:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10: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')]} 18:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:14 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 0x103b5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b624c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab84d2a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ffd30>, '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 0x103823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039f6b20>, '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.F1LZwrMbJz/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.47Es9zfbWG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 18:10:14 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 18:10:14 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 18:10:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1LZwrMbJz/Render', 18:10:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:14 INFO - 'HOME': '/Users/cltbld', 18:10:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:14 INFO - 'LOGNAME': 'cltbld', 18:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:14 INFO - 'MOZ_NO_REMOTE': '1', 18:10:14 INFO - 'NO_EM_RESTART': '1', 18:10:14 INFO - 'PAGER': '/bin/cat', 18:10:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:14 INFO - 'PWD': '/builds/slave/test', 18:10:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:14 INFO - 'SHELL': '/bin/bash', 18:10:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.47Es9zfbWG/Listeners', 18:10:14 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 18:10:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:14 INFO - 'USER': 'cltbld', 18:10:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:14 INFO - 'XPC_FLAGS': '0x0', 18:10:14 INFO - 'XPC_SERVICE_NAME': '0', 18:10:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:10:15 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-DeN0zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:10:15 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)) 18:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:10:15 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-_g6J2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:10:15 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)) 18:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:10:15 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-wGUrtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:10:15 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)) 18:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:10:15 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-K8rE4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:10:15 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)) 18:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:10:15 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Mdwl8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:10:15 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)) 18:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:10:15 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-wKA4rA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:10:15 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)) 18:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:10:15 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-LeEAEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:10:15 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)) 18:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:10:15 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-_C7fIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:10:15 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)) 18:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:10:15 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-hKchif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:10:16 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)) 18:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:10:16 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-b2GjNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:10:16 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)) 18:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:10:16 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-6vDlcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:10:16 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)) 18:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:10:16 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-zzz4i9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:10:16 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)) 18:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:10:16 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-zI8VSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:10:16 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)) 18:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:10:16 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-WhgsuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:10:16 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)) 18:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:16 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-7niqCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:16 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)) 18:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:10:16 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-tymt6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:10:16 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)) 18:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:10:16 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-vE_zOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:10:16 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)) 18:10:16 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)) 18:10:16 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)) 18:10:16 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)) 18:10:16 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)) 18:10:16 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)) 18:10:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:10:16 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 18:10:16 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 18:10:16 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 18:10:16 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 18:10:16 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 18:10:16 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 18:10:19 INFO - Downloading blessings-1.6.tar.gz 18:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:10:19 INFO - Installing collected packages: blessings 18:10:19 INFO - Running setup.py install for blessings 18:10:19 INFO - Successfully installed blessings 18:10:19 INFO - Cleaning up... 18:10:19 INFO - Return code: 0 18:10:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:10:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:10:19 INFO - Reading from file tmpfile_stdout 18:10:19 INFO - Current package versions: 18:10:19 INFO - blessings == 1.6 18:10:19 INFO - blobuploader == 1.2.4 18:10:19 INFO - docopt == 0.6.1 18:10:19 INFO - manifestparser == 1.1 18:10:19 INFO - mozInstall == 1.12 18:10:19 INFO - mozcrash == 0.16 18:10:19 INFO - mozdebug == 0.1 18:10:19 INFO - mozdevice == 0.48 18:10:19 INFO - mozfile == 1.2 18:10:19 INFO - mozhttpd == 0.7 18:10:19 INFO - mozinfo == 0.9 18:10:19 INFO - mozleak == 0.1 18:10:19 INFO - mozlog == 3.1 18:10:19 INFO - moznetwork == 0.27 18:10:19 INFO - mozprocess == 0.22 18:10:19 INFO - mozprofile == 0.28 18:10:19 INFO - mozrunner == 6.11 18:10:19 INFO - mozscreenshot == 0.1 18:10:19 INFO - mozsystemmonitor == 0.0 18:10:19 INFO - moztest == 0.7 18:10:19 INFO - mozversion == 1.4 18:10:19 INFO - psutil == 3.1.1 18:10:19 INFO - requests == 1.2.3 18:10:19 INFO - wsgiref == 0.1.2 18:10:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10: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')]} 18:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10: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')]} 18:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:19 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 0x103b5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b624c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab84d2a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ffd30>, '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 0x103823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039f6b20>, '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.F1LZwrMbJz/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.47Es9zfbWG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 18:10:19 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 18:10:19 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 18:10:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1LZwrMbJz/Render', 18:10:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:19 INFO - 'HOME': '/Users/cltbld', 18:10:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:19 INFO - 'LOGNAME': 'cltbld', 18:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:19 INFO - 'MOZ_NO_REMOTE': '1', 18:10:19 INFO - 'NO_EM_RESTART': '1', 18:10:19 INFO - 'PAGER': '/bin/cat', 18:10:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:19 INFO - 'PWD': '/builds/slave/test', 18:10:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:19 INFO - 'SHELL': '/bin/bash', 18:10:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.47Es9zfbWG/Listeners', 18:10:19 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 18:10:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:19 INFO - 'USER': 'cltbld', 18:10:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:19 INFO - 'XPC_FLAGS': '0x0', 18:10:19 INFO - 'XPC_SERVICE_NAME': '0', 18:10:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:20 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)) 18:10:20 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)) 18:10:20 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)) 18:10:20 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)) 18:10:20 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)) 18:10:20 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)) 18:10:20 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)) 18:10:20 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)) 18:10:20 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)) 18:10:20 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)) 18:10:20 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)) 18:10:20 INFO - Cleaning up... 18:10:20 INFO - Return code: 0 18:10:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103b5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b624c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab84d2a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ffd30>, '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 0x103823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039f6b20>, '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.F1LZwrMbJz/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.47Es9zfbWG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 18:10:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:10:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1LZwrMbJz/Render', 18:10:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:20 INFO - 'HOME': '/Users/cltbld', 18:10:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:20 INFO - 'LOGNAME': 'cltbld', 18:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:20 INFO - 'MOZ_NO_REMOTE': '1', 18:10:20 INFO - 'NO_EM_RESTART': '1', 18:10:20 INFO - 'PAGER': '/bin/cat', 18:10:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:20 INFO - 'PWD': '/builds/slave/test', 18:10:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:20 INFO - 'SHELL': '/bin/bash', 18:10:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.47Es9zfbWG/Listeners', 18:10:20 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 18:10:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:20 INFO - 'USER': 'cltbld', 18:10:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:20 INFO - 'XPC_FLAGS': '0x0', 18:10:20 INFO - 'XPC_SERVICE_NAME': '0', 18:10:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:20 INFO - Downloading/unpacking jsonschema 18:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:10:22 INFO - Downloading/unpacking functools32 (from jsonschema) 18:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:22 INFO - Downloading functools32-3.2.3-2.tar.gz 18:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:10:23 INFO - warning: no files found matching '*.txt' 18:10:23 INFO - no previously-included directories found matching 'build' 18:10:23 INFO - no previously-included directories found matching 'dist' 18:10:23 INFO - no previously-included directories found matching '.git*' 18:10:23 INFO - Installing collected packages: jsonschema, functools32 18:10:23 INFO - Running setup.py install for functools32 18:10:23 INFO - warning: no files found matching '*.txt' 18:10:23 INFO - no previously-included directories found matching 'build' 18:10:23 INFO - no previously-included directories found matching 'dist' 18:10:23 INFO - no previously-included directories found matching '.git*' 18:10:23 INFO - Successfully installed jsonschema functools32 18:10:23 INFO - Cleaning up... 18:10:23 INFO - Return code: 0 18:10:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:23 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 0x103b5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b624c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faab84d2a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ffd30>, '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 0x103823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039f6b20>, '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.F1LZwrMbJz/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.47Es9zfbWG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 18:10:23 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 18:10:23 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 18:10:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1LZwrMbJz/Render', 18:10:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:23 INFO - 'HOME': '/Users/cltbld', 18:10:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:23 INFO - 'LOGNAME': 'cltbld', 18:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:23 INFO - 'MOZ_NO_REMOTE': '1', 18:10:23 INFO - 'NO_EM_RESTART': '1', 18:10:23 INFO - 'PAGER': '/bin/cat', 18:10:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:23 INFO - 'PWD': '/builds/slave/test', 18:10:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:23 INFO - 'SHELL': '/bin/bash', 18:10:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.47Es9zfbWG/Listeners', 18:10:23 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 18:10:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:23 INFO - 'USER': 'cltbld', 18:10:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:23 INFO - 'XPC_FLAGS': '0x0', 18:10:23 INFO - 'XPC_SERVICE_NAME': '0', 18:10:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:23 INFO - Downloading/unpacking flake8 18:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:10:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:10: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 18:10: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 18:10: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 18:10: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 18:10: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 18:10: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 18:10:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:10:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:10: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 18:10: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 18:10: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 18:10: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 18:10: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 18:10: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 18:10:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:10: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 18:10: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 18:10: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 18:10: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 18:10: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 18:10: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 18:10:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:10:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:10:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:10:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:10:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:10:27 INFO - no previously-included directories found matching 'docs/_build' 18:10:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:10:27 INFO - Running setup.py install for pep8 18:10:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:10:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:10:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:10:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:10:27 INFO - no previously-included directories found matching 'docs/_build' 18:10:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:10:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:10:27 INFO - Cleaning up... 18:10:27 INFO - Return code: 0 18:10:27 INFO - Running post-action listener: _resource_record_post_action 18:10:27 INFO - Running post-action listener: _start_resource_monitoring 18:10:27 INFO - Starting resource monitoring. 18:10:27 INFO - ##### 18:10:27 INFO - ##### Running install step. 18:10:27 INFO - ##### 18:10:27 INFO - Running pre-action listener: _resource_record_pre_action 18:10:27 INFO - Running main action method: install 18:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:10:27 INFO - Reading from file tmpfile_stdout 18:10:27 INFO - Detecting whether we're running mozinstall >=1.0... 18:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:10:28 INFO - Reading from file tmpfile_stdout 18:10:28 INFO - Output received: 18:10:28 INFO - Usage: mozinstall [options] installer 18:10:28 INFO - Options: 18:10:28 INFO - -h, --help show this help message and exit 18:10:28 INFO - -d DEST, --destination=DEST 18:10:28 INFO - Directory to install application into. [default: 18:10:28 INFO - "/builds/slave/test"] 18:10:28 INFO - --app=APP Application being installed. [default: firefox] 18:10:28 INFO - mkdir: /builds/slave/test/build/application 18:10:28 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'] 18:10:28 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 18:11:01 INFO - Reading from file tmpfile_stdout 18:11:01 INFO - Output received: 18:11:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:11:01 INFO - Running post-action listener: _resource_record_post_action 18:11:01 INFO - ##### 18:11:01 INFO - ##### Running run-tests step. 18:11:01 INFO - ##### 18:11:01 INFO - Running pre-action listener: _resource_record_pre_action 18:11:01 INFO - Running main action method: run_tests 18:11:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:11:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:11:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:11:01 INFO - 2016-02-16 18:11:01.513 screenresolution[1949:13856] starting screenresolution argv=screenresolution get 18:11:01 INFO - 2016-02-16 18:11:01.516 screenresolution[1949:13856] Display 0: 1600x1200x32@60 18:11:01 INFO - 2016-02-16 18:11:01.522 screenresolution[1950:13859] starting screenresolution argv=screenresolution list 18:11:01 INFO - Available Modes on Display 0 18:11:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:11:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:11:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:11:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:11:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:11:01 INFO - Intel Iris: 18:11:01 INFO - Chipset Model: Intel Iris 18:11:01 INFO - Type: GPU 18:11:01 INFO - Bus: Built-In 18:11:01 INFO - VRAM (Dynamic, Max): 1536 MB 18:11:01 INFO - Vendor: Intel (0x8086) 18:11:01 INFO - Device ID: 0x0a2e 18:11:01 INFO - Revision ID: 0x0009 18:11:01 INFO - Displays: 18:11:01 INFO - Display: 18:11:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:11:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:11:01 INFO - Display Serial Number: 1600x1200 60 18:11:01 INFO - Main Display: Yes 18:11:01 INFO - Mirror: Off 18:11:01 INFO - Online: Yes 18:11:01 INFO - Rotation: Supported 18:11:01 INFO - Return code: 0 18:11:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:11:01 INFO - Python 2.7.3 18:11:01 INFO - Return code: 0 18:11:01 INFO - grabbing minidump binary from tooltool 18:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:01 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 0x1039ffd30>, '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 0x103823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039f6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:11:01 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 18:11:01 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 18:11:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:11:01 INFO - Return code: 0 18:11:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:11:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:11:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:11:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:11:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:11:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:11:03 INFO - Return code: 0 18:11:03 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/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--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 18:11:03 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/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0025 --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 18:11:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1LZwrMbJz/Render', 18:11:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:03 INFO - 'HOME': '/Users/cltbld', 18:11:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:03 INFO - 'LOGNAME': 'cltbld', 18:11:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:11:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:03 INFO - 'MOZ_NO_REMOTE': '1', 18:11:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:11:03 INFO - 'NO_EM_RESTART': '1', 18:11:03 INFO - 'PAGER': '/bin/cat', 18:11:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:03 INFO - 'PWD': '/builds/slave/test', 18:11:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:11:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:03 INFO - 'SHELL': '/bin/bash', 18:11:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.47Es9zfbWG/Listeners', 18:11:03 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 18:11:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:03 INFO - 'USER': 'cltbld', 18:11:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:03 INFO - 'XPC_FLAGS': '0x0', 18:11:03 INFO - 'XPC_SERVICE_NAME': '0', 18:11:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:03 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/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--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 18:11:03 INFO - mozversion application_buildid: 20160216163450 18:11:03 INFO - mozversion application_changeset: bf152107a11d801dec09449aa24140bd4d9f518e 18:11:03 INFO - mozversion application_display_name: Nightly 18:11:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:11:03 INFO - mozversion application_name: Firefox 18:11:03 INFO - mozversion application_remotingname: firefox 18:11:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:11:03 INFO - mozversion application_vendor: Mozilla 18:11:03 INFO - mozversion application_version: 47.0a1 18:11:03 INFO - mozversion platform_buildid: 20160216163450 18:11:03 INFO - mozversion platform_changeset: bf152107a11d801dec09449aa24140bd4d9f518e 18:11:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:11:03 INFO - mozversion platform_version: 47.0a1 18:11:03 INFO - using testdate: 1455675063 18:11:03 INFO - actual date: 1455675063 18:11:03 INFO - starting webserver on 'localhost:49649' 18:11:03 INFO - SUITE-START | Running 2 tests 18:11:03 INFO - TEST-START | dromaeo_css 18:11:03 INFO - operating with platform_type : mac_ 18:11:03 INFO - Initialising browser for dromaeo_css test... 18:11:03 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpQ5dh1C/profile http://localhost:49649/getInfo.html) 18:11:06 INFO - PROCESS | 1968 | __metrics Screen width/height:1600/1200 18:11:06 INFO - PROCESS | 1968 | colorDepth:24 18:11:06 INFO - PROCESS | 1968 | Browser inner width/height: 1024/689 18:11:06 INFO - PROCESS | 1968 | __metrics 18:11:06 ERROR - PROCESS | 1968 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 18:11:06 INFO - TEST-INFO | 1968: exit 0 18:11:06 INFO - Browser initialized. 18:11:06 INFO - Running cycle 1/1 for dromaeo_css test... 18:11:06 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpQ5dh1C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:11:18 INFO - PROCESS | 1972 | RSS: Main: 256258048 18:11:18 INFO - PROCESS | 1972 | 18:12:08 INFO - PROCESS | 1972 | 1455675128618 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] 18:14:19 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49649/tests/dromaeo/cssquery-ext.html) 18:14:20 INFO - PROCESS | 1972 | RSS: Main: 271425536 18:14:20 INFO - PROCESS | 1972 | 18:17:22 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-ext.html (next: http://localhost:49649/tests/dromaeo/cssquery-jquery.html) 18:17:23 INFO - PROCESS | 1972 | RSS: Main: 282812416 18:17:23 INFO - PROCESS | 1972 | 18:20:25 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49649/tests/dromaeo/cssquery-mootools.html) 18:20:25 INFO - PROCESS | 1972 | RSS: Main: 284893184 18:20:25 INFO - PROCESS | 1972 | 18:23:27 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49649/tests/dromaeo/cssquery-prototype.html) 18:23:27 INFO - PROCESS | 1972 | RSS: Main: 286715904 18:23:27 INFO - PROCESS | 1972 | 18:26:30 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49649/tests/dromaeo/cssquery-yui.html) 18:26:31 INFO - PROCESS | 1972 | RSS: Main: 288100352 18:26:31 INFO - PROCESS | 1972 | 18:29:33 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-yui.html (next: http://localhost:49649/tests/dromaeo/cssquery-dojo.html) 18:29:33 INFO - PROCESS | 1972 | RSS: Main: 291753984 18:29:33 INFO - PROCESS | 1972 | 18:29:33 INFO - PROCESS | 1972 | __start_tp_report 18:29:33 INFO - PROCESS | 1972 | _x_x_mozilla_page_load 18:29:33 INFO - PROCESS | 1972 | _x_x_mozilla_page_load_details 18:29:33 INFO - PROCESS | 1972 | |i|pagename|runs| 18:29:33 INFO - PROCESS | 1972 | |0;dojo.html;3551.644835516449;3557.8398972046257;3602.2435288589395;3628.34689755844;3637.2907283079794;5912.7930522431725;5955.612885162462;5975.551833612481;5986.640801551905;5987.28152621686;5821.09772985188;5991.910121348173;6008.429199226078;6071.574989750719;6105.969470152643;5337.252784610148;5388.191771234307;5403.8108666196695;5453.563714902798;5495.862603434926;5359.892802143974;5409.26974858395;5441.2654291670715;5452.073147564904;5495.670259784406;5241.0042092002395;5257.8159764408065;5377.435369286208;5401.918971215435;5429.6742195468205;5355.973220133875;5359.437259087778;5364.812231571916;5365.946340536584;5404.459554044564;5240.4759524047295;5315.893682126336;5384.19237114436;5402.459754024605;5435.809746658888;5769.855753606152;5789.899919015374;5864.266966629171;5915.497182739472;5951.166836642873;6313.85135975715;6328.873422531569;6342.429181373698;6367.8408039798915;6387.105805187278;6240.937590624081;6367.968160159216;6423.518236132309;6423.582467139621;6465.515086368541;6062.666553339564;6094.512439004869;6095.939040609537;6108.572399932051;6110.052941794029;6574.243961944342;6578;6589.341065893468;6594.802155935234;6605.70274337656;6110.358412366726;6168.383161683796;6251.218597675291;6257.655828929453;6261;6387.936120638827;6402.8719425611225;6418.646974416359;6423.389777971085;6438.935610643927;6207.099970504251;6230.688465576703;6239.844003899848;6292.811215663537;6332;6254.093156492374;6301.52738544611;6304.117423560705;6316.652584107826;6343.080253363237;5055.646104772704;5056.115179843513;5057.898842023139;5066.341375621146;5094.541491265803;4386.758728269976;4484.753338566345;4524.615407690318;4583.335416364608;4586;5903;5945.672987985616;5958.433948774859;5972.940270597325;5981.910271345933;5362.812301569426;6253.937460625336;6410.64741439216;6427.871442571122;6439.195100612424;5931.139984702194;5974.193483879708;5996.070609055603;5996.190514280604;6035.124906888476;5528.585356098229;5542.97228513863;5545.916811247835;5548.140038294071;5565.220869078333;6422.133012043408;6486.902696459462;6633.6019838809825;6638.867222655616;6652.135222421151;6378.043293506012;6426.389492998158;6433.678316084271;6434.195725534309;6454.677266136769;6598.901016484852;6647.966760166169;6652.401283884474;6668.399844014062;6683.298253683293;6141.762184092961;6273.96863015682;6369.20384951881;6378.1070650108095;6378.394052564999;6357.90463143044;6393.041043843275;6422.133012043314;6425.421712045938;6432.935670643234;6115.635867915819;6150.446459818638;6250.312465628686;6269;6269.279032911274;6077.4226448487325;6214.40963108504;6214.968925155526;6236.220472440945;6236.812895613139;6108.839320529085;6173.104899789595;6188.2883468399905;6201.317855036033;6210.937890621217;6110.012029148408;6150.938490615036;6241.750329986931;6247.625142491465;6257.2804127525915;6133.233345831771;6188;6192.102145188832;6197.225346831646;6242.812715618538 18:29:33 INFO - PROCESS | 1972 | |1;ext.html;436.565617210875;448.7531857478388;474.34303489666803;568.6730130175149;601.4106175947574;30038.699613003864;38061.238775224476;38083.238335233276;38138.04654883629;38232.80883595582;41240.17519649605;41582.792086039524;41615;41638;41820.74537763872;7809.648565814524;8260.876086858701;9582.377145485556;9618.567164477616;9652.517374131301;9653.22774178064;9788.804223915517;9792.265580081523;9801.705948821547;9841.901580984206;9738.902610973906;9786.070323319273;9799.265055120895;9814.852777208347;9843.163331116828;9750.609975600968;9820.803583928317;9830.950845245763;9848.113669769755;9857.753556161082;9481.47851868147;9604.66383676568;9605.423674579548;9637.469939153343;9648.324617276794;38114.80942595269;38266.426003609966;38278;38306.42540361897;38397.0400739981;2758.7171965036355;3131.4676504994204;3206.9679303207135;3713.3687273163628;4026.559000412182;28852.855735721398;29487.70512294871;29854;29854.104376868512;29905.70094299051;2722.5507791214623;2731.590261460777;2881.3228891210547;2888.956665650017;2932.076395935295;429031;429466;429649;430241;430890.8455457734;64856.67571662112;65125.34874651288;65195.34804651987;65405.345946540874;65511;67259.66370168117;68891.31108688949;68908;68940.6552967242;69045.65477172683;16365.181740912907;16789.328426863034;16971.660566788596;17039.744403833953;17045.573860653334;12774.936125319315;12850.293233872228;12927.741445171232;12969.740605187844;12984.67538311531;20482.692759608617;21131.154753809675;21315;21320.893395532923;21408.678869816966;7549;7653.6938522459595;8661.480311181349;8705.6517739291;8841.352230320726;896.5293221058865;906.3383729877227;942.8632848237104;959.5729900194486;977.745786095606;28055.859720701676;28079.71920280771;28202.858985705352;28286.009989650265;28417;920.839741925179;1062.8830828608848;1065.1851333729703;1076.5209481780532;1100.378286268272;14272.85727142736;14648.416050159236;14788.260586970824;14890;15123;553237.2338138283;557577;570066;571364;573949;57231.42768572344;57692;58379.41620583825;58532;58610.70694646585;1436.1167881752647;1441.9495317663832;1446.0817380963165;1462.8025216595624;1474.6239708874168;23017.309480715605;23213.651795222748;28511.714882851735;28697.421641809065;29008.709912900602;55939.44060559342;57425.42574574201;57446.7127664359;57655.71172144113;57774;444968;448019;451415;452483;452805;31369;31627.367452651277;31655.20861978469;31945;32148.35703285968;44259.45091921767;45058.54941450675;45767.084658307314;45902.770486147354;45912.08175836531;35000.64999350076;36658.63341366552;37288.50845966239;37550.24899502049;39257;30803.69196308098;35950.82024589965;36329;36378.90863274106;36564.08589785277;31545.36909261848;35118.473222901164;35338.46992295169;36860.447093294155;37244.627553724116;28245.29386765265;29904.850475748353;31053.223669408446;31809.5228571567;33696.197127865584;22906.54186916219;25064.37339066538;25287.36781580475;25594.360140996625;25752.484950301263 18:29:33 INFO - PROCESS | 1972 | |2;jquery.html;365.70560698637604;368.9557253129624;372.6683251905804;374.77700768043024;376.36206629762563;14926.669962398693;18148.274069037237;20027;20759;20891.164353425862;11471.942640286787;11801.763964720722;11870.406479676003;11893.821592676095;19573.90213048933;3260.510923361491;5037.924431133536;5047.798088076482;5286.995470860544;6894.24163342032;7211.423086153095;7303.67133478992;7400.851982960337;7422.072240969879;7430.962845185766;7483.363914067284;7517.887231691529;7532.472726909118;7540.773776786677;7546.094468663768;7135.750248741295;7285.927140728578;7324.890126648104;7397.112346518398;7407.25927407263;6977.267386924351;7000.894986575206;7001.299870012958;7054.858902821915;7079.787606371766;23936.401589960216;25104.870280837407;26307.21078367652;26456.603150952753;27752.444951101068;2208;2412.662227288181;2455.435249892517;2608.074133682553;2777.222377734238;15445.922770386189;15788.447404340794;16004.4398446055;16007.839921600867;16541.503754887373;1797.6314855454732;1825.73526838609;1856.7214917762308;1906.713992901076;1908.246242734126;109053;113991.99999999917;116504.41747791291;124346;125732;18992.52518687044;19153.60579927509;19445.027748612796;19640.919749413635;20044.59910801776;27274;28242;28340.574891376647;28389.006384776432;28667.713322866923;8176;8412.8317433651;8477.70328038528;8483.278921291636;8497.915020849836;7150.821229469201;7583.331667033244;8624.439411438236;8653.740387788377;8658.91341086581;4354.238008348526;4362.302031674917;4440.311751678495;4477.910441791146;4482.058767658763;1698.464983530184;1888.763904511936;1897.7627796525435;1914.8659593828297;1983.8214560689607;829.9128591497927;849.46908182386;918.86676431917;993.1824760687924;1008.8032833597379;19655.803441965396;20027.29904453366;20254.49363765888;20281.594368112554;20788.480287992617;446.894979679775;449.85379751580865;458.72018068977894;460.64530311659837;488.2091012559676;5813.7383817728305;6225.315215326311;11177;11622.88377116218;11708.94145529284;403202;475021;476963;633973;760886;84862.15137848665;102037;118549.40725296491;123348;124953.37523312325;504.24363454817774;506.3366989244102;510.09203617560803;511.3914441814229;514.4880843560755;10915.781684366428;16441.753373699165;16847;18457.81542184561;19513.024348782787;48807.09543236603;49369.01261974669;51648.834676977276;52139.69650758609;52721;68733.65633171803;69079.65460172667;69739.65130174317;69847;69999;6420.2937676856445;6513.837154071186;7496.9250307498405;7656.349210317186;7989.480683755537;10285.897141028494;10713.946430267799;12084.45619947087;12223.266604003788;12299.016078713503;9045.954770226106;10279.897201027894;10572.995565421274;10632.30889992148;10635.521401536795;10279.449097487572;10442.791144177227;10534.315269507457;10666.520006599876;10834;8823.955880220557;9205.355625106446;10386.792264154523;10734.14126869833;10822.67531974042;7560.054993125859;7653.617319134132;7677.270659287582;7702.730404436042;7783.532988020737;8642.611082501428;9979;10591.152707783205;10790.406527641055;10809.783804324026 18:29:33 INFO - PROCESS | 1972 | |3;mootools.html;1432.2337549411068;1487.3827361644915;1759.5249282693674;1885.0951543259234;1915.1477592471356;7399.778006659795;7759.340456061242;8731.694390696326;8833.116688331163;8852.247558957488;8558.400911936167;8609.741707748763;8711.607977641006;8735.694250701226;8755.255803256714;2402.3994001499627;2427.1262345555588;2428.2229686500327;2433.75662433757;2436.062116085302;2327.080803082781;2429.125514814665;2481.950360992779;2487.117073438921;2489.5643262429003;2184.683220932972;2427.393151712072;2464.1006032798077;2471.5674756917556;2475.801935845137;2445.7554244575576;2467.8395904266345;2470.0984140788664;2478.962815557759;2479.603263477835;2449.963250551243;2460.606302991531;2467.198160597813;2472.097684345219;2482.2801387597574;8824.735257942271;8827.867581986275;8832.337574681924;8931.106889311017;8939.106089391074;5359.115745901921;5442.537384322337;5476.205950137208;5479.424660410639;5517.36550296713;3598.2803439312243;3649.178934739689;3713.1274150574595;3740.2893450244364;3754.3617585010343;1054.536004158168;1059.179136169467;1081.9404932728696;1082.2532452607675;1084.8101582223157;11913.10651701126;12196.878031219752;12383.62849114528;12416;12463.314517701523;4897.461279259279;4925.753712314442;4958.950410495849;4984.028114517634;5027.622928280321;10206.948965255126;10296.639617613348;10377.429241391645;10390.896091038992;10405.375677459377;5514.28314319144;5522.088855338904;5529.115341545334;5535.806246781343;5540.058190107691;5002.024605201951;5012.273220383024;5039.722815245197;5041.319421878073;5045.697258164522;3927.155661532784;3992.9800350998057;4016.176683779818;4032.556418793989;4042.4946881639794;1326.4362645875465;1341.2556031402664;1348.9460421583224;1351.709382482771;1360.4898163188805;999.6601155606983;1072.6031368393744;1115.1580556679655;1195.8923696867323;1291.1671971578467;6683.966580167165;7730.884036739453;7852.882206766903;7984.481008734414;8260.504369737835;1162.267771304073;1163.755611321615;1182.976340473203;1186.3890096600257;1191.0888170549536;6207.503399728011;6274.780382686584;6334.049892516067;6334.556581039283;6351.079093531412;10370.014848589371;10546.41994690284;10632;10646.893531064745;10726.892731072745;10334;10528.63149789769;10549.525271362807;10581.576736930436;10607.522661480252;8239.711610093618;8268.503889766633;8406.285465735358;8409.41134120618;8449.535275559903;6349.238091429058;6791.592504449552;8047.275745182727;8120.431569790294;8241.83516329682;9540.475273860004;9806.313558050868;9826.508674566387;9933.701988940344;9995;9989.500524973577;10043.548040338057;10153.695389138338;10171.7457063574;10218.131458825786;7621.047369078865;7658.961705191661;7670.42471814605;7735.458517903693;7736.303732664087;8253.628586713732;8321.875171872305;8343.624536895733;8395.622197001028;8444.324454043539;7785.493942893921;7856.803579910548;7954.164812694815;8003.239692229229;8096.87854682192;7706.7687969361;7794.493357931717;7800.4149688774705;7828.608569571613;7887.487313324616;7895.447318687637;7924.722634707758;7974.40191985615;8003.759887203393;8034.397420193626;7102.573845569283;7145.499815013107;7201;7202.71189152428;7203.675834587351;7111.53775004623;7203.8559228816175;7240.384567311838;7299.5255308404785;7326.853462930605 18:29:33 INFO - PROCESS | 1972 | |4;prototype.html;326.7565663580632;332.2242563613961;335.2791498278702;337.9611344695361;342.9948550771739;6737.595744255348;6848.178218613767;6867.313268673136;6868.690908909099;6899.827504312395;5495.697736624494;6038.154658347835;6270.683156537121;6798.252192258848;6812.420944219747;4149.336106223005;5067.619928505358;5104.208847628605;5110.897782044357;5139.614528910328;4407.911841763179;4850.156940362657;5096.541311281984;5110.693358398489;5150.201718733583;4732.787024583885;4883.560479556839;4896.8041278349;4898.559129678329;4932.6793758405765;4897.51024897511;4900.215965445529;4902.240152776325;4904.288878112671;4934.950650493485;4130.752154870687;4142.337226043848;4150.813213405404;4151.97924010378;4152.294110001307;4964.007198560303;5274.789008439658;6564;6599.373059559334;6617.900731489031;4651.418572678415;5582.63712858667;5838.737256823453;5842.678652674102;5860.531157507389;7345.77962661121;7348.485606007582;7356.970024196617;7357.742479013209;7387.926120738832;4363.934540981856;4488.955110448886;4607.14767767964;4627.930581041287;4636.976815115937;7665.731699390494;7680;7697.615119244071;7699.461037727306;7732.49738766984;4674.672772905864;4684.110019096429;4687.203175460112;4692.53074692528;4701.412323459567;4590.311453282035;4780.856574302777;4781.13939490895;4791.856244312677;4813.663043586916;4729.905401891943;5775.48020678141;5779.566532510079;5796.88406231873;5808.157817116495;7332.1934587195365;7355.117385913724;7355.59544225062;7371.48399612022;7388.113426388868;1634.8855580109516;1663.517579901839;1667.8332166783466;1671.030802134759;1672.0970675835156;1028.6296933104077;1057.7990181865575;1059.2532264753331;1066.7252633103521;1079.5465904320047;6548.1814773153355;6590.176227971504;6600.207975042929;6619.172603424572;6765.42493888025;7487.213842546563;7493.9883115778675;7496.250374962569;7531.924680753232;7539.886901696479;6518.902216466757;6577.276499585042;6639.734410623618;6641.568298060611;6848.863022739517;4030.8387664493093;4051;4052.9797351013644;4061.9796901015898;4079.5308539518337;7229.7469588564145;8009.31920786728;8024.478408903403;8037.67849286022;8454.239118479367;7698.769036928901;7984.24149705777;7991.041075071029;8006.959095317571;8011.118776934532;8004.239597238253;8041.035075790943;8060.476069055492;8064.83870322602;8102.83794324122;7327.890081648673;7499.512531685423;7721.420893433127;7741;7755.534667919943;6109;7531.736389226351;7535.13345965221;7587.506812057199;7616.276453736886;8049.51702897828;8052.15452377492;8053.476524025919;8057.677692892219;8061.516309021477;4567.2007398705755;4750.9287360690305;4764.857054288377;4765.35667684872;4784.4497882742535;6560.44236239925;7677.692892284246;7677.9232207677205;7687.231276872268;7724.884126738216;5816.883662326814;7080.575165489881;7399.186089530255;7414.480986331121;7437.739679111205;6124.020156775073;7342.229065947999;7378.450525389729;7408.073990751156;7425.220351863192;7175.461840362098;7221.025161603116;7224.855502890018;7237.095363079615;7260;6325.209348831396;7223;7375.188729239672;7402.592857392679;7415.629218538944;7223.458240632079;7235.674394652358;7236.095488063992;7238.203797582367;7243.855122897407 18:29:33 INFO - PROCESS | 1972 | |5;yui.html;667.4927055437868;699.2797418658781;738.9015791041815;741.2143128284016;744.1962680305271;14720.601542853425;14838;14849.92575037126;14950.850491495068;14969.850301496996;13602.659933501667;14034.157950522977;14186.929065354685;14191.432342706279;14227.21750303733;713.978580642579;751.6993202718902;846.1031306814765;872.7338161860662;875.2866413872673;870.3472395703222;873.4366333714781;874.5976850648709;880.2737741363369;884.2704768565927;912.4753266871576;926.5228407370209;927.9536023198847;929.330881765128;930.0745757970794;914.3873604684877;916.4501299220481;919.7378747057056;922.9400088994194;923.7736754495158;660.3858411677138;665.6937808608046;678.9932100679029;679.6296018669788;681.5467713970254;14334.211618360985;14360.856391436057;14371.922105841999;14402.279886005657;14412;12400.81398779019;12616.81074783879;13061;13423.731525369536;13715.794263086062;10063.24525660571;10163.59345626174;10166.440845753481;10203.948980255125;10227.79544409115;3452.637473065317;3553.4492153716214;3559.76861504004;3562.9109272268142;3579.409397449444;80270.59864700698;82808;83561;85751.57124214339;86517;9491.430514169171;9568.78973251767;9589.808203836024;9697.515124243759;9872.40765554069;21583.784162158492;21746.782532174475;21765.891170544044;21816.454588635093;22038.228661996753;7515.586642734593;7564.773056808304;7871.921280787119;7981.920180798234;8089;4138.710290279651;4158.542560318362;4165.354370072643;4181.498220213533;4202.243596152661;3583.928321433557;3585.1933315004435;3614.765040272374;3619.873304434332;3620.456931460302;642.8842808294552;648.2512697833915;649.5226008883467;672.8217022489044;672.9461643068543;496.8956519130951;567.8069456384849;620.5314987184647;620.6493331267819;631.2961048431058;6782.762603308861;8483.70307039263;8586.914130858737;8754.080821513777;8936.41913275635;439.7471453914012;473.6140045862611;531.9255304257407;541.9215760636305;543.8450041738085;3945.6251656092627;4016.9397459038137;4071.9796401017807;4138.337865941435;4149.460570125864;68489;87322;90117.19765604651;92368;92427.53786231026;76069;78879;79218;80329;80726.59636701897;69983;70746.292537075;71273.64363178254;71290.64354678194;72280.27719722735;7573;8210.958945205235;9035.096490350912;9107.134822191882;9224.123708247706;48175.759121204166;49581.00837983292;51124.488755111975;51813.740931295106;52228.47771522388;57336.71331643315;64832;64945.35054649393;71500;71644.64177679078;10831.783364332827;10869.29349592274;11193.160512961398;11219.382933938385;11431.085513158761;12102;12200.583836525788;12326.753464930473;12511.874881251435;12554.874451255371;11372.31766094037;11538.192326537397;11652.766944661229;11855.76497390966;11922.165448418527;11348.148888833206;11512.53949841997;11659.242149260272;12198.51205951752;12453.066020048715;11343.829842552534;11476.598319058792;11530.423478825858;11779.469923853276;12337.629871103882;8861.33539984491;9159.404638698463;9528.094830991045;9662.275329350467;10169.186465082628;9256.676016339396;9377.343585948918;9458.905410946078;9508.532593758755;10089.98583371571 18:29:33 INFO - PROCESS | 1972 | __end_tp_report 18:29:33 INFO - PROCESS | 1972 | __start_cc_report 18:29:33 INFO - PROCESS | 1972 | _x_x_mozilla_cycle_collect,359 18:29:33 INFO - PROCESS | 1972 | __end_cc_report 18:29:33 INFO - PROCESS | 1972 | __startTimestamp1455676173679__endTimestamp 18:29:33 INFO - PROCESS | 1972 | 18:29:33 INFO - PROCESS | 1972 | ------- Summary: start ------- 18:29:33 INFO - PROCESS | 1972 | Number of tests: 6 18:29:33 INFO - PROCESS | 1972 | 18:29:33 INFO - PROCESS | 1972 | [#0] dojo.html Cycles:165 Average:5924.58 Median:6141.76 stddev:641.16 (10.4%) stddev-sans-first:615.51 18:29:33 INFO - PROCESS | 1972 | Values: 3551.6 3557.8 3602.2 3628.3 3637.3 5912.8 5955.6 5975.6 5986.6 5987.3 5821.1 5991.9 6008.4 6071.6 6106.0 5337.3 5388.2 5403.8 5453.6 5495.9 5359.9 5409.3 5441.3 5452.1 5495.7 5241.0 5257.8 5377.4 5401.9 5429.7 5356.0 5359.4 5364.8 5365.9 5404.5 5240.5 5315.9 5384.2 5402.5 5435.8 5769.9 5789.9 5864.3 5915.5 5951.2 6313.9 6328.9 6342.4 6367.8 6387.1 6240.9 6368.0 6423.5 6423.6 6465.5 6062.7 6094.5 6095.9 6108.6 6110.1 6574.2 6578.0 6589.3 6594.8 6605.7 6110.4 6168.4 6251.2 6257.7 6261.0 6387.9 6402.9 6418.6 6423.4 6438.9 6207.1 6230.7 6239.8 6292.8 6332.0 6254.1 6301.5 6304.1 6316.7 6343.1 5055.6 5056.1 5057.9 5066.3 5094.5 4386.8 4484.8 4524.6 4583.3 4586.0 5903.0 5945.7 5958.4 5972.9 5981.9 5362.8 6253.9 6410.6 6427.9 6439.2 5931.1 5974.2 5996.1 5996.2 6035.1 5528.6 5543.0 5545.9 5548.1 5565.2 6422.1 6486.9 6633.6 6638.9 6652.1 6378.0 6426.4 6433.7 6434.2 6454.7 6598.9 6648.0 6652.4 6668.4 6683.3 6141.8 6274.0 6369.2 6378.1 6378.4 6357.9 6393.0 6422.1 6425.4 6432.9 6115.6 6150.4 6250.3 6269.0 6269.3 6077.4 6214.4 6215.0 6236.2 6236.8 6108.8 6173.1 6188.3 6201.3 6210.9 6110.0 6150.9 6241.8 6247.6 6257.3 6133.2 6188.0 6192.1 6197.2 6242.8 18:29:33 INFO - PROCESS | 1972 | 18:29:33 INFO - PROCESS | 1972 | [#1] ext.html Cycles:180 Average:62984.26 Median:38351.73 stddev:129103.20 (336.6%) stddev-sans-first:129379.96 18:29:33 INFO - PROCESS | 1972 | Values: 436.6 448.8 474.3 568.7 601.4 30038.7 38061.2 38083.2 38138.0 38232.8 41240.2 41582.8 41615.0 41638.0 41820.7 7809.6 8260.9 9582.4 9618.6 9652.5 9653.2 9788.8 9792.3 9801.7 9841.9 9738.9 9786.1 9799.3 9814.9 9843.2 9750.6 9820.8 9831.0 9848.1 9857.8 9481.5 9604.7 9605.4 9637.5 9648.3 38114.8 38266.4 38278.0 38306.4 38397.0 2758.7 3131.5 3207.0 3713.4 4026.6 28852.9 29487.7 29854.0 29854.1 29905.7 2722.6 2731.6 2881.3 2889.0 2932.1 429031.0 429466.0 429649.0 430241.0 430890.8 64856.7 65125.3 65195.3 65405.3 65511.0 67259.7 68891.3 68908.0 68940.7 69045.7 16365.2 16789.3 16971.7 17039.7 17045.6 12774.9 12850.3 12927.7 12969.7 12984.7 20482.7 21131.2 21315.0 21320.9 21408.7 7549.0 7653.7 8661.5 8705.7 8841.4 896.5 906.3 942.9 959.6 977.7 28055.9 28079.7 28202.9 28286.0 28417.0 920.8 1062.9 1065.2 1076.5 1100.4 14272.9 14648.4 14788.3 14890.0 15123.0 553237.2 557577.0 570066.0 571364.0 573949.0 57231.4 57692.0 58379.4 58532.0 58610.7 1436.1 1441.9 1446.1 1462.8 1474.6 23017.3 23213.7 28511.7 28697.4 29008.7 55939.4 57425.4 57446.7 57655.7 57774.0 444968.0 448019.0 451415.0 452483.0 452805.0 31369.0 31627.4 31655.2 31945.0 32148.4 44259.5 45058.5 45767.1 45902.8 45912.1 35000.6 36658.6 37288.5 37550.2 39257.0 30803.7 35950.8 36329.0 36378.9 36564.1 31545.4 35118.5 35338.5 36860.4 37244.6 28245.3 29904.9 31053.2 31809.5 33696.2 22906.5 25064.4 25287.4 25594.4 25752.5 18:29:33 INFO - PROCESS | 1972 | 18:29:33 INFO - PROCESS | 1972 | [#2] jquery.html Cycles:180 Average:33276.53 Median:370.81 stddev:94223.34 (25410.0%) stddev-sans-first:94455.26 18:29:33 INFO - PROCESS | 1972 | Values: 365.7 369.0 372.7 374.8 376.4 14926.7 18148.3 20027.0 20759.0 20891.2 11471.9 11801.8 11870.4 11893.8 19573.9 3260.5 5037.9 5047.8 5287.0 6894.2 7211.4 7303.7 7400.9 7422.1 7431.0 7483.4 7517.9 7532.5 7540.8 7546.1 7135.8 7285.9 7324.9 7397.1 7407.3 6977.3 7000.9 7001.3 7054.9 7079.8 23936.4 25104.9 26307.2 26456.6 27752.4 2208.0 2412.7 2455.4 2608.1 2777.2 15445.9 15788.4 16004.4 16007.8 16541.5 1797.6 1825.7 1856.7 1906.7 1908.2 109053.0 113992.0 116504.4 124346.0 125732.0 18992.5 19153.6 19445.0 19640.9 20044.6 27274.0 28242.0 28340.6 28389.0 28667.7 8176.0 8412.8 8477.7 8483.3 8497.9 7150.8 7583.3 8624.4 8653.7 8658.9 4354.2 4362.3 4440.3 4477.9 4482.1 1698.5 1888.8 1897.8 1914.9 1983.8 829.9 849.5 918.9 993.2 1008.8 19655.8 20027.3 20254.5 20281.6 20788.5 446.9 449.9 458.7 460.6 488.2 5813.7 6225.3 11177.0 11622.9 11708.9 403202.0 475021.0 476963.0 633973.0 760886.0 84862.2 102037.0 118549.4 123348.0 124953.4 504.2 506.3 510.1 511.4 514.5 10915.8 16441.8 16847.0 18457.8 19513.0 48807.1 49369.0 51648.8 52139.7 52721.0 68733.7 69079.7 69739.7 69847.0 69999.0 6420.3 6513.8 7496.9 7656.3 7989.5 10285.9 10713.9 12084.5 12223.3 12299.0 9046.0 10279.9 10573.0 10632.3 10635.5 10279.4 10442.8 10534.3 10666.5 10834.0 8824.0 9205.4 10386.8 10734.1 10822.7 7560.1 7653.6 7677.3 7702.7 7783.5 8642.6 9979.0 10591.2 10790.4 10809.8 18:29:33 INFO - PROCESS | 1972 | 18:29:33 INFO - PROCESS | 1972 | [#3] mootools.html Cycles:180 Average:6134.16 Median:5040.52 stddev:3224.83 (64.0%) stddev-sans-first:3214.51 18:29:33 INFO - PROCESS | 1972 | Values: 1432.2 1487.4 1759.5 1885.1 1915.1 7399.8 7759.3 8731.7 8833.1 8852.2 8558.4 8609.7 8711.6 8735.7 8755.3 2402.4 2427.1 2428.2 2433.8 2436.1 2327.1 2429.1 2482.0 2487.1 2489.6 2184.7 2427.4 2464.1 2471.6 2475.8 2445.8 2467.8 2470.1 2479.0 2479.6 2450.0 2460.6 2467.2 2472.1 2482.3 8824.7 8827.9 8832.3 8931.1 8939.1 5359.1 5442.5 5476.2 5479.4 5517.4 3598.3 3649.2 3713.1 3740.3 3754.4 1054.5 1059.2 1081.9 1082.3 1084.8 11913.1 12196.9 12383.6 12416.0 12463.3 4897.5 4925.8 4959.0 4984.0 5027.6 10206.9 10296.6 10377.4 10390.9 10405.4 5514.3 5522.1 5529.1 5535.8 5540.1 5002.0 5012.3 5039.7 5041.3 5045.7 3927.2 3993.0 4016.2 4032.6 4042.5 1326.4 1341.3 1348.9 1351.7 1360.5 999.7 1072.6 1115.2 1195.9 1291.2 6684.0 7730.9 7852.9 7984.5 8260.5 1162.3 1163.8 1183.0 1186.4 1191.1 6207.5 6274.8 6334.0 6334.6 6351.1 10370.0 10546.4 10632.0 10646.9 10726.9 10334.0 10528.6 10549.5 10581.6 10607.5 8239.7 8268.5 8406.3 8409.4 8449.5 6349.2 6791.6 8047.3 8120.4 8241.8 9540.5 9806.3 9826.5 9933.7 9995.0 9989.5 10043.5 10153.7 10171.7 10218.1 7621.0 7659.0 7670.4 7735.5 7736.3 8253.6 8321.9 8343.6 8395.6 8444.3 7785.5 7856.8 7954.2 8003.2 8096.9 7706.8 7794.5 7800.4 7828.6 7887.5 7895.4 7924.7 7974.4 8003.8 8034.4 7102.6 7145.5 7201.0 7202.7 7203.7 7111.5 7203.9 7240.4 7299.5 7326.9 18:29:33 INFO - PROCESS | 1972 | 18:29:33 INFO - PROCESS | 1972 | [#4] prototype.html Cycles:180 Average:5921.20 Median:6599.79 stddev:1956.68 (29.6%) stddev-sans-first:1916.59 18:29:33 INFO - PROCESS | 1972 | Values: 326.8 332.2 335.3 338.0 343.0 6737.6 6848.2 6867.3 6868.7 6899.8 5495.7 6038.2 6270.7 6798.3 6812.4 4149.3 5067.6 5104.2 5110.9 5139.6 4407.9 4850.2 5096.5 5110.7 5150.2 4732.8 4883.6 4896.8 4898.6 4932.7 4897.5 4900.2 4902.2 4904.3 4935.0 4130.8 4142.3 4150.8 4152.0 4152.3 4964.0 5274.8 6564.0 6599.4 6617.9 4651.4 5582.6 5838.7 5842.7 5860.5 7345.8 7348.5 7357.0 7357.7 7387.9 4363.9 4489.0 4607.1 4627.9 4637.0 7665.7 7680.0 7697.6 7699.5 7732.5 4674.7 4684.1 4687.2 4692.5 4701.4 4590.3 4780.9 4781.1 4791.9 4813.7 4729.9 5775.5 5779.6 5796.9 5808.2 7332.2 7355.1 7355.6 7371.5 7388.1 1634.9 1663.5 1667.8 1671.0 1672.1 1028.6 1057.8 1059.3 1066.7 1079.5 6548.2 6590.2 6600.2 6619.2 6765.4 7487.2 7494.0 7496.3 7531.9 7539.9 6518.9 6577.3 6639.7 6641.6 6848.9 4030.8 4051.0 4053.0 4062.0 4079.5 7229.7 8009.3 8024.5 8037.7 8454.2 7698.8 7984.2 7991.0 8007.0 8011.1 8004.2 8041.0 8060.5 8064.8 8102.8 7327.9 7499.5 7721.4 7741.0 7755.5 6109.0 7531.7 7535.1 7587.5 7616.3 8049.5 8052.2 8053.5 8057.7 8061.5 4567.2 4750.9 4764.9 4765.4 4784.4 6560.4 7677.7 7677.9 7687.2 7724.9 5816.9 7080.6 7399.2 7414.5 7437.7 6124.0 7342.2 7378.5 7408.1 7425.2 7175.5 7221.0 7224.9 7237.1 7260.0 6325.2 7223.0 7375.2 7402.6 7415.6 7223.5 7235.7 7236.1 7238.2 7243.9 18:29:33 INFO - PROCESS | 1972 | 18:29:33 INFO - PROCESS | 1972 | [#5] yui.html Cycles:180 Average:18308.70 Median:620.59 stddev:25525.94 (4113.2%) stddev-sans-first:25563.18 18:29:33 INFO - PROCESS | 1972 | Values: 667.5 699.3 738.9 741.2 744.2 14720.6 14838.0 14849.9 14950.9 14969.9 13602.7 14034.2 14186.9 14191.4 14227.2 714.0 751.7 846.1 872.7 875.3 870.3 873.4 874.6 880.3 884.3 912.5 926.5 928.0 929.3 930.1 914.4 916.5 919.7 922.9 923.8 660.4 665.7 679.0 679.6 681.5 14334.2 14360.9 14371.9 14402.3 14412.0 12400.8 12616.8 13061.0 13423.7 13715.8 10063.2 10163.6 10166.4 10203.9 10227.8 3452.6 3553.4 3559.8 3562.9 3579.4 80270.6 82808.0 83561.0 85751.6 86517.0 9491.4 9568.8 9589.8 9697.5 9872.4 21583.8 21746.8 21765.9 21816.5 22038.2 7515.6 7564.8 7871.9 7981.9 8089.0 4138.7 4158.5 4165.4 4181.5 4202.2 3583.9 3585.2 3614.8 3619.9 3620.5 642.9 648.3 649.5 672.8 672.9 496.9 567.8 620.5 620.6 631.3 6782.8 8483.7 8586.9 8754.1 8936.4 439.7 473.6 531.9 541.9 543.8 3945.6 4016.9 4072.0 4138.3 4149.5 68489.0 87322.0 90117.2 92368.0 92427.5 76069.0 78879.0 79218.0 80329.0 80726.6 69983.0 70746.3 71273.6 71290.6 72280.3 7573.0 8211.0 9035.1 9107.1 9224.1 48175.8 49581.0 51124.5 51813.7 52228.5 57336.7 64832.0 64945.4 71500.0 71644.6 10831.8 10869.3 11193.2 11219.4 11431.1 12102.0 12200.6 12326.8 12511.9 12554.9 11372.3 11538.2 11652.8 11855.8 11922.2 11348.1 11512.5 11659.2 12198.5 12453.1 11343.8 11476.6 11530.4 11779.5 12337.6 8861.3 9159.4 9528.1 9662.3 10169.2 9256.7 9377.3 9458.9 9508.5 10090.0 18:29:33 INFO - PROCESS | 1972 | -------- Summary: end -------- 18:29:33 INFO - PROCESS | 1972 | 18:29:34 INFO - TEST-INFO | 1972: exit 0 18:29:34 INFO - TEST-OK | dromaeo_css | took 1110879ms 18:29:34 INFO - TEST-START | kraken 18:29:34 INFO - operating with platform_type : mac_ 18:29:34 INFO - Initialising browser for kraken test... 18:29:34 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpDA1E8V/profile http://localhost:49649/getInfo.html) 18:29:37 INFO - PROCESS | 1976 | __metrics Screen width/height:1600/1200 18:29:37 INFO - PROCESS | 1976 | colorDepth:24 18:29:37 INFO - PROCESS | 1976 | Browser inner width/height: 1024/689 18:29:37 INFO - PROCESS | 1976 | __metrics 18:29:37 ERROR - PROCESS | 1976 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 18:29:37 INFO - TEST-INFO | 1976: exit 0 18:29:37 INFO - Browser initialized. 18:29:37 INFO - Running cycle 1/1 for kraken test... 18:29:37 INFO - TEST-INFO | started process 1979 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpDA1E8V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:29:49 INFO - PROCESS | 1979 | RSS: Main: 255873024 18:29:49 INFO - PROCESS | 1979 | 18:29:52 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-beat-detection) 18:29:53 INFO - PROCESS | 1979 | RSS: Main: 268632064 18:29:53 INFO - PROCESS | 1979 | 18:29:55 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-dft) 18:29:56 INFO - PROCESS | 1979 | RSS: Main: 276164608 18:29:56 INFO - PROCESS | 1979 | 18:29:59 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-fft) 18:30:00 INFO - PROCESS | 1979 | RSS: Main: 281231360 18:30:00 INFO - PROCESS | 1979 | 18:30:02 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-oscillator) 18:30:02 INFO - PROCESS | 1979 | RSS: Main: 283033600 18:30:02 INFO - PROCESS | 1979 | 18:30:04 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49649/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:30:05 INFO - PROCESS | 1979 | RSS: Main: 283844608 18:30:05 INFO - PROCESS | 1979 | 18:30:08 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49649/tests/kraken/driver.html?testName=imaging-darkroom) 18:30:09 INFO - PROCESS | 1979 | RSS: Main: 283111424 18:30:09 INFO - PROCESS | 1979 | 18:30:12 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49649/tests/kraken/driver.html?testName=imaging-desaturate) 18:30:12 INFO - PROCESS | 1979 | RSS: Main: 283176960 18:30:12 INFO - PROCESS | 1979 | 18:30:15 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49649/tests/kraken/driver.html?testName=json-parse-financial) 18:30:16 INFO - PROCESS | 1979 | RSS: Main: 283246592 18:30:16 INFO - PROCESS | 1979 | 18:30:17 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49649/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:30:18 INFO - PROCESS | 1979 | RSS: Main: 283029504 18:30:18 INFO - PROCESS | 1979 | 18:30:20 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:30:21 INFO - PROCESS | 1979 | RSS: Main: 284262400 18:30:21 INFO - PROCESS | 1979 | 18:30:23 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:30:23 INFO - PROCESS | 1979 | RSS: Main: 284532736 18:30:23 INFO - PROCESS | 1979 | 18:30:26 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:30:27 INFO - PROCESS | 1979 | RSS: Main: 283770880 18:30:27 INFO - PROCESS | 1979 | 18:30:29 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:30:30 INFO - PROCESS | 1979 | RSS: Main: 283369472 18:30:30 INFO - PROCESS | 1979 | 18:30:31 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49649/tests/kraken/driver.html?testName=ai-astar) 18:30:32 INFO - PROCESS | 1979 | RSS: Main: 284585984 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | __start_tp_report 18:30:32 INFO - PROCESS | 1979 | _x_x_mozilla_page_load 18:30:32 INFO - PROCESS | 1979 | _x_x_mozilla_page_load_details 18:30:32 INFO - PROCESS | 1979 | |i|pagename|runs| 18:30:32 INFO - PROCESS | 1979 | |0;ai-astar;114;110;112;113;114;125;113;114;118;165 18:30:32 INFO - PROCESS | 1979 | |1;audio-beat-detection;154;125;150;167;153;143;140;127;153;107 18:30:32 INFO - PROCESS | 1979 | |2;audio-dft;215;272;249;202;227;202;195;196;198;194 18:30:32 INFO - PROCESS | 1979 | |3;audio-fft;75;70;73;110;71;79;85;83;124;58 18:30:32 INFO - PROCESS | 1979 | |4;audio-oscillator;84;86;124;81;81;82;118;82;82;116 18:30:32 INFO - PROCESS | 1979 | |5;imaging-gaussian-blur;133;92;95;142;85;109;130;91;85;93 18:30:32 INFO - PROCESS | 1979 | |6;imaging-darkroom;128;152;91;92;133;114;142;146;154;95 18:30:32 INFO - PROCESS | 1979 | |7;imaging-desaturate;92;94;132;140;147;91;95;93;92;134 18:30:32 INFO - PROCESS | 1979 | |8;json-parse-financial;54;57;55;56;55;57;56;62;56;63 18:30:32 INFO - PROCESS | 1979 | |9;json-stringify-tinderbox;62;69;66;69;63;66;66;70;100;100 18:30:32 INFO - PROCESS | 1979 | |10;stanford-crypto-aes;87;84;84;86;82;85;84;87;84;84 18:30:32 INFO - PROCESS | 1979 | |11;stanford-crypto-ccm;151;140;149;135;139;111;118;162;119;133 18:30:32 INFO - PROCESS | 1979 | |12;stanford-crypto-pbkdf2;127;138;146;173;174;141;141;143;140;140 18:30:32 INFO - PROCESS | 1979 | |13;stanford-crypto-sha256-iterative;69;69;67;69;70;67;66;70;92;86 18:30:32 INFO - PROCESS | 1979 | __end_tp_report 18:30:32 INFO - PROCESS | 1979 | __start_cc_report 18:30:32 INFO - PROCESS | 1979 | _x_x_mozilla_cycle_collect,865 18:30:32 INFO - PROCESS | 1979 | __end_cc_report 18:30:32 INFO - PROCESS | 1979 | __startTimestamp1455676232141__endTimestamp 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | ------- Summary: start ------- 18:30:32 INFO - PROCESS | 1979 | Number of tests: 14 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | [#0] ai-astar Cycles:10 Average:119.80 Median:114.00 stddev:16.41 (14.4%) stddev-sans-first:17.27 18:30:32 INFO - PROCESS | 1979 | Values: 114.0 110.0 112.0 113.0 114.0 125.0 113.0 114.0 118.0 165.0 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:151.50 stddev:17.70 (11.7%) stddev-sans-first:18.22 18:30:32 INFO - PROCESS | 1979 | Values: 154.0 125.0 150.0 167.0 153.0 143.0 140.0 127.0 153.0 107.0 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | [#2] audio-dft Cycles:10 Average:215.00 Median:208.50 stddev:26.62 (12.8%) stddev-sans-first:28.24 18:30:32 INFO - PROCESS | 1979 | Values: 215.0 272.0 249.0 202.0 227.0 202.0 195.0 196.0 198.0 194.0 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | [#3] audio-fft Cycles:10 Average:82.80 Median:74.00 stddev:19.81 (26.8%) stddev-sans-first:20.81 18:30:32 INFO - PROCESS | 1979 | Values: 75.0 70.0 73.0 110.0 71.0 79.0 85.0 83.0 124.0 58.0 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:82.00 stddev:17.93 (21.9%) stddev-sans-first:18.67 18:30:32 INFO - PROCESS | 1979 | Values: 84.0 86.0 124.0 81.0 81.0 82.0 118.0 82.0 82.0 116.0 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | [#5] imaging-gaussian-blur Cycles:10 Average:105.50 Median:88.00 stddev:21.60 (24.5%) stddev-sans-first:20.49 18:30:32 INFO - PROCESS | 1979 | Values: 133.0 92.0 95.0 142.0 85.0 109.0 130.0 91.0 85.0 93.0 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | [#6] imaging-darkroom Cycles:10 Average:124.70 Median:153.00 stddev:25.03 (16.4%) stddev-sans-first:26.52 18:30:32 INFO - PROCESS | 1979 | Values: 128.0 152.0 91.0 92.0 133.0 114.0 142.0 146.0 154.0 95.0 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | [#7] imaging-desaturate Cycles:10 Average:111.00 Median:92.00 stddev:23.80 (25.9%) stddev-sans-first:24.23 18:30:32 INFO - PROCESS | 1979 | Values: 92.0 94.0 132.0 140.0 147.0 91.0 95.0 93.0 92.0 134.0 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.50 stddev:3.00 (5.3%) stddev-sans-first:2.96 18:30:32 INFO - PROCESS | 1979 | Values: 54.0 57.0 55.0 56.0 55.0 57.0 56.0 62.0 56.0 63.0 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:66.00 stddev:14.40 (21.8%) stddev-sans-first:14.71 18:30:32 INFO - PROCESS | 1979 | Values: 62.0 69.0 66.0 69.0 63.0 66.0 66.0 70.0 100.0 100.0 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.50 stddev:1.57 (1.9%) stddev-sans-first:1.42 18:30:32 INFO - PROCESS | 1979 | Values: 87.0 84.0 84.0 86.0 82.0 85.0 84.0 87.0 84.0 84.0 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:139.50 stddev:16.13 (11.6%) stddev-sans-first:16.13 18:30:32 INFO - PROCESS | 1979 | Values: 151.0 140.0 149.0 135.0 139.0 111.0 118.0 162.0 119.0 133.0 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:142.00 stddev:15.16 (10.7%) stddev-sans-first:14.38 18:30:32 INFO - PROCESS | 1979 | Values: 127.0 138.0 146.0 173.0 174.0 141.0 141.0 143.0 140.0 140.0 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - PROCESS | 1979 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:69.50 stddev:8.91 (12.8%) stddev-sans-first:9.36 18:30:32 INFO - PROCESS | 1979 | Values: 69.0 69.0 67.0 69.0 70.0 67.0 66.0 70.0 92.0 86.0 18:30:32 INFO - PROCESS | 1979 | -------- Summary: end -------- 18:30:32 INFO - PROCESS | 1979 | 18:30:32 INFO - TEST-INFO | 1979: exit 0 18:30:32 INFO - TEST-OK | kraken | took 58669ms 18:30:32 INFO - SUITE-END | took 1169s 18:30:33 INFO - Completed test suite (00:19:29) 18:30:33 INFO - Working with test: dromaeo_css 18:30:33 INFO - Generating results file: dromaeo_css 18:30:33 INFO - Working with test: kraken 18:30:33 INFO - Generating results file: kraken 18:30:33 INFO - javascript benchmark 18:30:33 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:30:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 18:30:33 INFO - process_Request line: dromaeo_css 7624.70 graph.html#tests=[[72,64,61]] 18:30:33 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:30:33 INFO - process_Request line: kraken 1563.70 graph.html#tests=[[232,64,61]] 18:30:33 INFO - RETURN: dromaeo_css: 7624.70 18:30:33 INFO - RETURN: kraken: 1563.70 18:30:33 INFO - javascript benchmark 18:30:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3551.644835516449, 3557.8398972046257, 3602.2435288589395, 3628.34689755844, 3637.2907283079794, 5912.7930522431725, 5955.612885162462, 5975.551833612481, 5986.640801551905, 5987.28152621686, 5821.09772985188, 5991.910121348173, 6008.429199226078, 6071.574989750719, 6105.969470152643, 5337.252784610148, 5388.191771234307, 5403.8108666196695, 5453.563714902798, 5495.862603434926, 5359.892802143974, 5409.26974858395, 5441.2654291670715, 5452.073147564904, 5495.670259784406, 5241.0042092002395, 5257.8159764408065, 5377.435369286208, 5401.918971215435, 5429.6742195468205, 5355.973220133875, 5359.437259087778, 5364.812231571916, 5365.946340536584, 5404.459554044564, 5240.4759524047295, 5315.893682126336, 5384.19237114436, 5402.459754024605, 5435.809746658888, 5769.855753606152, 5789.899919015374, 5864.266966629171, 5915.497182739472, 5951.166836642873, 6313.85135975715, 6328.873422531569, 6342.429181373698, 6367.8408039798915, 6387.105805187278, 6240.937590624081, 6367.968160159216, 6423.518236132309, 6423.582467139621, 6465.515086368541, 6062.666553339564, 6094.512439004869, 6095.939040609537, 6108.572399932051, 6110.052941794029, 6574.243961944342, 6578.0, 6589.341065893468, 6594.802155935234, 6605.70274337656, 6110.358412366726, 6168.383161683796, 6251.218597675291, 6257.655828929453, 6261.0, 6387.936120638827, 6402.8719425611225, 6418.646974416359, 6423.389777971085, 6438.935610643927, 6207.099970504251, 6230.688465576703, 6239.844003899848, 6292.811215663537, 6332.0, 6254.093156492374, 6301.52738544611, 6304.117423560705, 6316.652584107826, 6343.080253363237, 5055.646104772704, 5056.115179843513, 5057.898842023139, 5066.341375621146, 5094.541491265803, 4386.758728269976, 4484.753338566345, 4524.615407690318, 4583.335416364608, 4586.0, 5903.0, 5945.672987985616, 5958.433948774859, 5972.940270597325, 5981.910271345933, 5362.812301569426, 6253.937460625336, 6410.64741439216, 6427.871442571122, 6439.195100612424, 5931.139984702194, 5974.193483879708, 5996.070609055603, 5996.190514280604, 6035.124906888476, 5528.585356098229, 5542.97228513863, 5545.916811247835, 5548.140038294071, 5565.220869078333, 6422.133012043408, 6486.902696459462, 6633.6019838809825, 6638.867222655616, 6652.135222421151, 6378.043293506012, 6426.389492998158, 6433.678316084271, 6434.195725534309, 6454.677266136769, 6598.901016484852, 6647.966760166169, 6652.401283884474, 6668.399844014062, 6683.298253683293, 6141.762184092961, 6273.96863015682, 6369.20384951881, 6378.1070650108095, 6378.394052564999, 6357.90463143044, 6393.041043843275, 6422.133012043314, 6425.421712045938, 6432.935670643234, 6115.635867915819, 6150.446459818638, 6250.312465628686, 6269.0, 6269.279032911274, 6077.4226448487325, 6214.40963108504, 6214.968925155526, 6236.220472440945, 6236.812895613139, 6108.839320529085, 6173.104899789595, 6188.2883468399905, 6201.317855036033, 6210.937890621217, 6110.012029148408, 6150.938490615036, 6241.750329986931, 6247.625142491465, 6257.2804127525915, 6133.233345831771, 6188.0, 6192.102145188832, 6197.225346831646, 6242.812715618538], "unit": "score", "name": "dojo.html", "value": 5884.7030432012425}, {"lowerIsBetter": false, "replicates": [436.565617210875, 448.7531857478388, 474.34303489666803, 568.6730130175149, 601.4106175947574, 30038.699613003864, 38061.238775224476, 38083.238335233276, 38138.04654883629, 38232.80883595582, 41240.17519649605, 41582.792086039524, 41615.0, 41638.0, 41820.74537763872, 7809.648565814524, 8260.876086858701, 9582.377145485556, 9618.567164477616, 9652.517374131301, 9653.22774178064, 9788.804223915517, 9792.265580081523, 9801.705948821547, 9841.901580984206, 9738.902610973906, 9786.070323319273, 9799.265055120895, 9814.852777208347, 9843.163331116828, 9750.609975600968, 9820.803583928317, 9830.950845245763, 9848.113669769755, 9857.753556161082, 9481.47851868147, 9604.66383676568, 9605.423674579548, 9637.469939153343, 9648.324617276794, 38114.80942595269, 38266.426003609966, 38278.0, 38306.42540361897, 38397.0400739981, 2758.7171965036355, 3131.4676504994204, 3206.9679303207135, 3713.3687273163628, 4026.559000412182, 28852.855735721398, 29487.70512294871, 29854.0, 29854.104376868512, 29905.70094299051, 2722.5507791214623, 2731.590261460777, 2881.3228891210547, 2888.956665650017, 2932.076395935295, 429031.0, 429466.0, 429649.0, 430241.0, 430890.8455457734, 64856.67571662112, 65125.34874651288, 65195.34804651987, 65405.345946540874, 65511.0, 67259.66370168117, 68891.31108688949, 68908.0, 68940.6552967242, 69045.65477172683, 16365.181740912907, 16789.328426863034, 16971.660566788596, 17039.744403833953, 17045.573860653334, 12774.936125319315, 12850.293233872228, 12927.741445171232, 12969.740605187844, 12984.67538311531, 20482.692759608617, 21131.154753809675, 21315.0, 21320.893395532923, 21408.678869816966, 7549.0, 7653.6938522459595, 8661.480311181349, 8705.6517739291, 8841.352230320726, 896.5293221058865, 906.3383729877227, 942.8632848237104, 959.5729900194486, 977.745786095606, 28055.859720701676, 28079.71920280771, 28202.858985705352, 28286.009989650265, 28417.0, 920.839741925179, 1062.8830828608848, 1065.1851333729703, 1076.5209481780532, 1100.378286268272, 14272.85727142736, 14648.416050159236, 14788.260586970824, 14890.0, 15123.0, 553237.2338138283, 557577.0, 570066.0, 571364.0, 573949.0, 57231.42768572344, 57692.0, 58379.41620583825, 58532.0, 58610.70694646585, 1436.1167881752647, 1441.9495317663832, 1446.0817380963165, 1462.8025216595624, 1474.6239708874168, 23017.309480715605, 23213.651795222748, 28511.714882851735, 28697.421641809065, 29008.709912900602, 55939.44060559342, 57425.42574574201, 57446.7127664359, 57655.71172144113, 57774.0, 444968.0, 448019.0, 451415.0, 452483.0, 452805.0, 31369.0, 31627.367452651277, 31655.20861978469, 31945.0, 32148.35703285968, 44259.45091921767, 45058.54941450675, 45767.084658307314, 45902.770486147354, 45912.08175836531, 35000.64999350076, 36658.63341366552, 37288.50845966239, 37550.24899502049, 39257.0, 30803.69196308098, 35950.82024589965, 36329.0, 36378.90863274106, 36564.08589785277, 31545.36909261848, 35118.473222901164, 35338.46992295169, 36860.447093294155, 37244.627553724116, 28245.29386765265, 29904.850475748353, 31053.223669408446, 31809.5228571567, 33696.197127865584, 22906.54186916219, 25064.37339066538, 25287.36781580475, 25594.360140996625, 25752.484950301263], "unit": "score", "name": "ext.html", "value": 19605.035723608336}, {"lowerIsBetter": false, "replicates": [365.70560698637604, 368.9557253129624, 372.6683251905804, 374.77700768043024, 376.36206629762563, 14926.669962398693, 18148.274069037237, 20027.0, 20759.0, 20891.164353425862, 11471.942640286787, 11801.763964720722, 11870.406479676003, 11893.821592676095, 19573.90213048933, 3260.510923361491, 5037.924431133536, 5047.798088076482, 5286.995470860544, 6894.24163342032, 7211.423086153095, 7303.67133478992, 7400.851982960337, 7422.072240969879, 7430.962845185766, 7483.363914067284, 7517.887231691529, 7532.472726909118, 7540.773776786677, 7546.094468663768, 7135.750248741295, 7285.927140728578, 7324.890126648104, 7397.112346518398, 7407.25927407263, 6977.267386924351, 7000.894986575206, 7001.299870012958, 7054.858902821915, 7079.787606371766, 23936.401589960216, 25104.870280837407, 26307.21078367652, 26456.603150952753, 27752.444951101068, 2208.0, 2412.662227288181, 2455.435249892517, 2608.074133682553, 2777.222377734238, 15445.922770386189, 15788.447404340794, 16004.4398446055, 16007.839921600867, 16541.503754887373, 1797.6314855454732, 1825.73526838609, 1856.7214917762308, 1906.713992901076, 1908.246242734126, 109053.0, 113991.99999999917, 116504.41747791291, 124346.0, 125732.0, 18992.52518687044, 19153.60579927509, 19445.027748612796, 19640.919749413635, 20044.59910801776, 27274.0, 28242.0, 28340.574891376647, 28389.006384776432, 28667.713322866923, 8176.0, 8412.8317433651, 8477.70328038528, 8483.278921291636, 8497.915020849836, 7150.821229469201, 7583.331667033244, 8624.439411438236, 8653.740387788377, 8658.91341086581, 4354.238008348526, 4362.302031674917, 4440.311751678495, 4477.910441791146, 4482.058767658763, 1698.464983530184, 1888.763904511936, 1897.7627796525435, 1914.8659593828297, 1983.8214560689607, 829.9128591497927, 849.46908182386, 918.86676431917, 993.1824760687924, 1008.8032833597379, 19655.803441965396, 20027.29904453366, 20254.49363765888, 20281.594368112554, 20788.480287992617, 446.894979679775, 449.85379751580865, 458.72018068977894, 460.64530311659837, 488.2091012559676, 5813.7383817728305, 6225.315215326311, 11177.0, 11622.88377116218, 11708.94145529284, 403202.0, 475021.0, 476963.0, 633973.0, 760886.0, 84862.15137848665, 102037.0, 118549.40725296491, 123348.0, 124953.37523312325, 504.24363454817774, 506.3366989244102, 510.09203617560803, 511.3914441814229, 514.4880843560755, 10915.781684366428, 16441.753373699165, 16847.0, 18457.81542184561, 19513.024348782787, 48807.09543236603, 49369.01261974669, 51648.834676977276, 52139.69650758609, 52721.0, 68733.65633171803, 69079.65460172667, 69739.65130174317, 69847.0, 69999.0, 6420.2937676856445, 6513.837154071186, 7496.9250307498405, 7656.349210317186, 7989.480683755537, 10285.897141028494, 10713.946430267799, 12084.45619947087, 12223.266604003788, 12299.016078713503, 9045.954770226106, 10279.897201027894, 10572.995565421274, 10632.30889992148, 10635.521401536795, 10279.449097487572, 10442.791144177227, 10534.315269507457, 10666.520006599876, 10834.0, 8823.955880220557, 9205.355625106446, 10386.792264154523, 10734.14126869833, 10822.67531974042, 7560.054993125859, 7653.617319134132, 7677.270659287582, 7702.730404436042, 7783.532988020737, 8642.611082501428, 9979.0, 10591.152707783205, 10790.406527641055, 10809.783804324026], "unit": "score", "name": "jquery.html", "value": 9372.965460230324}, {"lowerIsBetter": false, "replicates": [1432.2337549411068, 1487.3827361644915, 1759.5249282693674, 1885.0951543259234, 1915.1477592471356, 7399.778006659795, 7759.340456061242, 8731.694390696326, 8833.116688331163, 8852.247558957488, 8558.400911936167, 8609.741707748763, 8711.607977641006, 8735.694250701226, 8755.255803256714, 2402.3994001499627, 2427.1262345555588, 2428.2229686500327, 2433.75662433757, 2436.062116085302, 2327.080803082781, 2429.125514814665, 2481.950360992779, 2487.117073438921, 2489.5643262429003, 2184.683220932972, 2427.393151712072, 2464.1006032798077, 2471.5674756917556, 2475.801935845137, 2445.7554244575576, 2467.8395904266345, 2470.0984140788664, 2478.962815557759, 2479.603263477835, 2449.963250551243, 2460.606302991531, 2467.198160597813, 2472.097684345219, 2482.2801387597574, 8824.735257942271, 8827.867581986275, 8832.337574681924, 8931.106889311017, 8939.106089391074, 5359.115745901921, 5442.537384322337, 5476.205950137208, 5479.424660410639, 5517.36550296713, 3598.2803439312243, 3649.178934739689, 3713.1274150574595, 3740.2893450244364, 3754.3617585010343, 1054.536004158168, 1059.179136169467, 1081.9404932728696, 1082.2532452607675, 1084.8101582223157, 11913.10651701126, 12196.878031219752, 12383.62849114528, 12416.0, 12463.314517701523, 4897.461279259279, 4925.753712314442, 4958.950410495849, 4984.028114517634, 5027.622928280321, 10206.948965255126, 10296.639617613348, 10377.429241391645, 10390.896091038992, 10405.375677459377, 5514.28314319144, 5522.088855338904, 5529.115341545334, 5535.806246781343, 5540.058190107691, 5002.024605201951, 5012.273220383024, 5039.722815245197, 5041.319421878073, 5045.697258164522, 3927.155661532784, 3992.9800350998057, 4016.176683779818, 4032.556418793989, 4042.4946881639794, 1326.4362645875465, 1341.2556031402664, 1348.9460421583224, 1351.709382482771, 1360.4898163188805, 999.6601155606983, 1072.6031368393744, 1115.1580556679655, 1195.8923696867323, 1291.1671971578467, 6683.966580167165, 7730.884036739453, 7852.882206766903, 7984.481008734414, 8260.504369737835, 1162.267771304073, 1163.755611321615, 1182.976340473203, 1186.3890096600257, 1191.0888170549536, 6207.503399728011, 6274.780382686584, 6334.049892516067, 6334.556581039283, 6351.079093531412, 10370.014848589371, 10546.41994690284, 10632.0, 10646.893531064745, 10726.892731072745, 10334.0, 10528.63149789769, 10549.525271362807, 10581.576736930436, 10607.522661480252, 8239.711610093618, 8268.503889766633, 8406.285465735358, 8409.41134120618, 8449.535275559903, 6349.238091429058, 6791.592504449552, 8047.275745182727, 8120.431569790294, 8241.83516329682, 9540.475273860004, 9806.313558050868, 9826.508674566387, 9933.701988940344, 9995.0, 9989.500524973577, 10043.548040338057, 10153.695389138338, 10171.7457063574, 10218.131458825786, 7621.047369078865, 7658.961705191661, 7670.42471814605, 7735.458517903693, 7736.303732664087, 8253.628586713732, 8321.875171872305, 8343.624536895733, 8395.622197001028, 8444.324454043539, 7785.493942893921, 7856.803579910548, 7954.164812694815, 8003.239692229229, 8096.87854682192, 7706.7687969361, 7794.493357931717, 7800.4149688774705, 7828.608569571613, 7887.487313324616, 7895.447318687637, 7924.722634707758, 7974.40191985615, 8003.759887203393, 8034.397420193626, 7102.573845569283, 7145.499815013107, 7201.0, 7202.71189152428, 7203.675834587351, 7111.53775004623, 7203.8559228816175, 7240.384567311838, 7299.5255308404785, 7326.853462930605], "unit": "score", "name": "mootools.html", "value": 4996.585528811941}, {"lowerIsBetter": false, "replicates": [326.7565663580632, 332.2242563613961, 335.2791498278702, 337.9611344695361, 342.9948550771739, 6737.595744255348, 6848.178218613767, 6867.313268673136, 6868.690908909099, 6899.827504312395, 5495.697736624494, 6038.154658347835, 6270.683156537121, 6798.252192258848, 6812.420944219747, 4149.336106223005, 5067.619928505358, 5104.208847628605, 5110.897782044357, 5139.614528910328, 4407.911841763179, 4850.156940362657, 5096.541311281984, 5110.693358398489, 5150.201718733583, 4732.787024583885, 4883.560479556839, 4896.8041278349, 4898.559129678329, 4932.6793758405765, 4897.51024897511, 4900.215965445529, 4902.240152776325, 4904.288878112671, 4934.950650493485, 4130.752154870687, 4142.337226043848, 4150.813213405404, 4151.97924010378, 4152.294110001307, 4964.007198560303, 5274.789008439658, 6564.0, 6599.373059559334, 6617.900731489031, 4651.418572678415, 5582.63712858667, 5838.737256823453, 5842.678652674102, 5860.531157507389, 7345.77962661121, 7348.485606007582, 7356.970024196617, 7357.742479013209, 7387.926120738832, 4363.934540981856, 4488.955110448886, 4607.14767767964, 4627.930581041287, 4636.976815115937, 7665.731699390494, 7680.0, 7697.615119244071, 7699.461037727306, 7732.49738766984, 4674.672772905864, 4684.110019096429, 4687.203175460112, 4692.53074692528, 4701.412323459567, 4590.311453282035, 4780.856574302777, 4781.13939490895, 4791.856244312677, 4813.663043586916, 4729.905401891943, 5775.48020678141, 5779.566532510079, 5796.88406231873, 5808.157817116495, 7332.1934587195365, 7355.117385913724, 7355.59544225062, 7371.48399612022, 7388.113426388868, 1634.8855580109516, 1663.517579901839, 1667.8332166783466, 1671.030802134759, 1672.0970675835156, 1028.6296933104077, 1057.7990181865575, 1059.2532264753331, 1066.7252633103521, 1079.5465904320047, 6548.1814773153355, 6590.176227971504, 6600.207975042929, 6619.172603424572, 6765.42493888025, 7487.213842546563, 7493.9883115778675, 7496.250374962569, 7531.924680753232, 7539.886901696479, 6518.902216466757, 6577.276499585042, 6639.734410623618, 6641.568298060611, 6848.863022739517, 4030.8387664493093, 4051.0, 4052.9797351013644, 4061.9796901015898, 4079.5308539518337, 7229.7469588564145, 8009.31920786728, 8024.478408903403, 8037.67849286022, 8454.239118479367, 7698.769036928901, 7984.24149705777, 7991.041075071029, 8006.959095317571, 8011.118776934532, 8004.239597238253, 8041.035075790943, 8060.476069055492, 8064.83870322602, 8102.83794324122, 7327.890081648673, 7499.512531685423, 7721.420893433127, 7741.0, 7755.534667919943, 6109.0, 7531.736389226351, 7535.13345965221, 7587.506812057199, 7616.276453736886, 8049.51702897828, 8052.15452377492, 8053.476524025919, 8057.677692892219, 8061.516309021477, 4567.2007398705755, 4750.9287360690305, 4764.857054288377, 4765.35667684872, 4784.4497882742535, 6560.44236239925, 7677.692892284246, 7677.9232207677205, 7687.231276872268, 7724.884126738216, 5816.883662326814, 7080.575165489881, 7399.186089530255, 7414.480986331121, 7437.739679111205, 6124.020156775073, 7342.229065947999, 7378.450525389729, 7408.073990751156, 7425.220351863192, 7175.461840362098, 7221.025161603116, 7224.855502890018, 7237.095363079615, 7260.0, 6325.209348831396, 7223.0, 7375.188729239672, 7402.592857392679, 7415.629218538944, 7223.458240632079, 7235.674394652358, 7236.095488063992, 7238.203797582367, 7243.855122897407], "unit": "score", "name": "prototype.html", "value": 5269.256976434045}, {"lowerIsBetter": false, "replicates": [667.4927055437868, 699.2797418658781, 738.9015791041815, 741.2143128284016, 744.1962680305271, 14720.601542853425, 14838.0, 14849.92575037126, 14950.850491495068, 14969.850301496996, 13602.659933501667, 14034.157950522977, 14186.929065354685, 14191.432342706279, 14227.21750303733, 713.978580642579, 751.6993202718902, 846.1031306814765, 872.7338161860662, 875.2866413872673, 870.3472395703222, 873.4366333714781, 874.5976850648709, 880.2737741363369, 884.2704768565927, 912.4753266871576, 926.5228407370209, 927.9536023198847, 929.330881765128, 930.0745757970794, 914.3873604684877, 916.4501299220481, 919.7378747057056, 922.9400088994194, 923.7736754495158, 660.3858411677138, 665.6937808608046, 678.9932100679029, 679.6296018669788, 681.5467713970254, 14334.211618360985, 14360.856391436057, 14371.922105841999, 14402.279886005657, 14412.0, 12400.81398779019, 12616.81074783879, 13061.0, 13423.731525369536, 13715.794263086062, 10063.24525660571, 10163.59345626174, 10166.440845753481, 10203.948980255125, 10227.79544409115, 3452.637473065317, 3553.4492153716214, 3559.76861504004, 3562.9109272268142, 3579.409397449444, 80270.59864700698, 82808.0, 83561.0, 85751.57124214339, 86517.0, 9491.430514169171, 9568.78973251767, 9589.808203836024, 9697.515124243759, 9872.40765554069, 21583.784162158492, 21746.782532174475, 21765.891170544044, 21816.454588635093, 22038.228661996753, 7515.586642734593, 7564.773056808304, 7871.921280787119, 7981.920180798234, 8089.0, 4138.710290279651, 4158.542560318362, 4165.354370072643, 4181.498220213533, 4202.243596152661, 3583.928321433557, 3585.1933315004435, 3614.765040272374, 3619.873304434332, 3620.456931460302, 642.8842808294552, 648.2512697833915, 649.5226008883467, 672.8217022489044, 672.9461643068543, 496.8956519130951, 567.8069456384849, 620.5314987184647, 620.6493331267819, 631.2961048431058, 6782.762603308861, 8483.70307039263, 8586.914130858737, 8754.080821513777, 8936.41913275635, 439.7471453914012, 473.6140045862611, 531.9255304257407, 541.9215760636305, 543.8450041738085, 3945.6251656092627, 4016.9397459038137, 4071.9796401017807, 4138.337865941435, 4149.460570125864, 68489.0, 87322.0, 90117.19765604651, 92368.0, 92427.53786231026, 76069.0, 78879.0, 79218.0, 80329.0, 80726.59636701897, 69983.0, 70746.292537075, 71273.64363178254, 71290.64354678194, 72280.27719722735, 7573.0, 8210.958945205235, 9035.096490350912, 9107.134822191882, 9224.123708247706, 48175.759121204166, 49581.00837983292, 51124.488755111975, 51813.740931295106, 52228.47771522388, 57336.71331643315, 64832.0, 64945.35054649393, 71500.0, 71644.64177679078, 10831.783364332827, 10869.29349592274, 11193.160512961398, 11219.382933938385, 11431.085513158761, 12102.0, 12200.583836525788, 12326.753464930473, 12511.874881251435, 12554.874451255371, 11372.31766094037, 11538.192326537397, 11652.766944661229, 11855.76497390966, 11922.165448418527, 11348.148888833206, 11512.53949841997, 11659.242149260272, 12198.51205951752, 12453.066020048715, 11343.829842552534, 11476.598319058792, 11530.423478825858, 11779.469923853276, 12337.629871103882, 8861.33539984491, 9159.404638698463, 9528.094830991045, 9662.275329350467, 10169.186465082628, 9256.676016339396, 9377.343585948918, 9458.905410946078, 9508.532593758755, 10089.98583371571], "unit": "score", "name": "yui.html", "value": 6900.980204153136}], "name": "dromaeo_css", "value": 7624.696858447092}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 112.0, 113.0, 114.0, 125.0, 113.0, 114.0, 118.0, 165.0], "unit": "score", "name": "ai-astar", "value": 119.8}, {"lowerIsBetter": true, "replicates": [154.0, 125.0, 150.0, 167.0, 153.0, 143.0, 140.0, 127.0, 153.0, 107.0], "unit": "score", "name": "audio-beat-detection", "value": 141.9}, {"lowerIsBetter": true, "replicates": [215.0, 272.0, 249.0, 202.0, 227.0, 202.0, 195.0, 196.0, 198.0, 194.0], "unit": "score", "name": "audio-dft", "value": 215.0}, {"lowerIsBetter": true, "replicates": [75.0, 70.0, 73.0, 110.0, 71.0, 79.0, 85.0, 83.0, 124.0, 58.0], "unit": "score", "name": "audio-fft", "value": 82.8}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 124.0, 81.0, 81.0, 82.0, 118.0, 82.0, 82.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 93.6}, {"lowerIsBetter": true, "replicates": [133.0, 92.0, 95.0, 142.0, 85.0, 109.0, 130.0, 91.0, 85.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 105.5}, {"lowerIsBetter": true, "replicates": [128.0, 152.0, 91.0, 92.0, 133.0, 114.0, 142.0, 146.0, 154.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 124.7}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 132.0, 140.0, 147.0, 91.0, 95.0, 93.0, 92.0, 134.0], "unit": "score", "name": "imaging-desaturate", "value": 111.0}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 55.0, 56.0, 55.0, 57.0, 56.0, 62.0, 56.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [62.0, 69.0, 66.0, 69.0, 63.0, 66.0, 66.0, 70.0, 100.0, 100.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.1}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 84.0, 86.0, 82.0, 85.0, 84.0, 87.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [151.0, 140.0, 149.0, 135.0, 139.0, 111.0, 118.0, 162.0, 119.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 135.7}, {"lowerIsBetter": true, "replicates": [127.0, 138.0, 146.0, 173.0, 174.0, 141.0, 141.0, 143.0, 140.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 67.0, 69.0, 70.0, 67.0, 66.0, 70.0, 92.0, 86.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.5}], "name": "kraken", "value": 1563.7}]} 18:30:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1563.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7624.70"}}} 18:30:33 INFO - Return code: 0 18:30:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:30:33 ERROR - # TBPL SUCCESS # 18:30:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:30:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:30:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:30:33 INFO - 2016-02-16 18:30:33.879 screenresolution[1985:16590] starting screenresolution argv=screenresolution get 18:30:33 INFO - 2016-02-16 18:30:33.881 screenresolution[1985:16590] Display 0: 1600x1200x32@60 18:30:33 INFO - 2016-02-16 18:30:33.887 screenresolution[1986:16593] starting screenresolution argv=screenresolution list 18:30:33 INFO - Available Modes on Display 0 18:30:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:30:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:30:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:30:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:30:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:30:34 INFO - Intel Iris: 18:30:34 INFO - Chipset Model: Intel Iris 18:30:34 INFO - Type: GPU 18:30:34 INFO - Bus: Built-In 18:30:34 INFO - VRAM (Dynamic, Max): 1536 MB 18:30:34 INFO - Vendor: Intel (0x8086) 18:30:34 INFO - Device ID: 0x0a2e 18:30:34 INFO - Revision ID: 0x0009 18:30:34 INFO - Displays: 18:30:34 INFO - Display: 18:30:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:30:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:30:34 INFO - Display Serial Number: 1600x1200 60 18:30:34 INFO - Main Display: Yes 18:30:34 INFO - Mirror: Off 18:30:34 INFO - Online: Yes 18:30:34 INFO - Rotation: Supported 18:30:34 INFO - Return code: 0 18:30:34 INFO - Running post-action listener: _resource_record_post_action 18:30:34 INFO - Running post-run listener: _resource_record_post_run 18:30:35 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 2371584; Write bytes: 711759872; Read time: 34; Write time: 1935 18:30:35 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 388676096; Write bytes: 383366144; Read time: 28757; Write time: 650 18:30:35 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 2371584; Write bytes: 305083392; Read time: 34; Write time: 1233 18:30:35 INFO - Running post-run listener: _upload_blobber_files 18:30:35 INFO - Blob upload gear active. 18:30:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:30:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:30:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:30:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:30:35 INFO - (blobuploader) - INFO - Open directory for files ... 18:30:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:30:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:30:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:36 INFO - (blobuploader) - INFO - Done attempting. 18:30:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:30:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:30:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:38 INFO - (blobuploader) - INFO - Done attempting. 18:30:38 INFO - (blobuploader) - INFO - Iteration through files over. 18:30:38 INFO - Return code: 0 18:30:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:30:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:30:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/262e0fd02176f27e630af53e646d59d1239c41727f3b48366efc0fd2c3fabceb10cb4f1095cff9873cccd1befae43152d026370ccc1bfc1b1adde4453545fc27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/76795095f776634d7ce9e8f3c38a1898743b8b1c5232d93e0381487d86e4ee6a97ea89043066e629f10777504e2608a8f533c66f55fab0a156abb70c7af65506"} 18:30:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:30:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:30:38 INFO - Contents: 18:30:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/262e0fd02176f27e630af53e646d59d1239c41727f3b48366efc0fd2c3fabceb10cb4f1095cff9873cccd1befae43152d026370ccc1bfc1b1adde4453545fc27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/76795095f776634d7ce9e8f3c38a1898743b8b1c5232d93e0381487d86e4ee6a97ea89043066e629f10777504e2608a8f533c66f55fab0a156abb70c7af65506"} 18:30:38 INFO - Running post-run listener: copy_logs_to_upload_dir 18:30:38 INFO - Copying logs to upload dir... 18:30:38 INFO - mkdir: /builds/slave/test/build/upload/logs 18:30:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.691054 ========= master_lag: 0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-16 18:30:38.421259) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 18:30:38.428057) ========= 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.F1LZwrMbJz/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.47Es9zfbWG/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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/262e0fd02176f27e630af53e646d59d1239c41727f3b48366efc0fd2c3fabceb10cb4f1095cff9873cccd1befae43152d026370ccc1bfc1b1adde4453545fc27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/76795095f776634d7ce9e8f3c38a1898743b8b1c5232d93e0381487d86e4ee6a97ea89043066e629f10777504e2608a8f533c66f55fab0a156abb70c7af65506"} build_url:https://queue.taskcluster.net/v1/task/RGW6ooI7SO-uoVIO_IdkXg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011049 build_url: 'https://queue.taskcluster.net/v1/task/RGW6ooI7SO-uoVIO_IdkXg/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/262e0fd02176f27e630af53e646d59d1239c41727f3b48366efc0fd2c3fabceb10cb4f1095cff9873cccd1befae43152d026370ccc1bfc1b1adde4453545fc27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/76795095f776634d7ce9e8f3c38a1898743b8b1c5232d93e0381487d86e4ee6a97ea89043066e629f10777504e2608a8f533c66f55fab0a156abb70c7af65506"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 18:30:38.488239) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 18:30:38.488617) ========= 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.F1LZwrMbJz/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.47Es9zfbWG/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.005049 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 18:30:38.543869) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 18:30:38.544168) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 18:30:38.544522) ========= ========= Total master_lag: 1.55 =========