builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0199 starttime: 1456484939.38 results: success (0) buildid: 20160226020723 builduid: 26d189fe0b594ae39c2b91d88e04172c revision: 3eb3e6986e4b34193f54618f9db800e28c10e9d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 03:08:59.375629) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 03:08:59.376057) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 03:08:59.376376) ========= 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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.005624 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 03:08:59.410909) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 03:08:59.411180) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 03:08:59.436813) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 03:08:59.437062) ========= 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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005569 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 03:08:59.489978) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 03:08:59.490244) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 03:08:59.490569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 03:08:59.490910) ========= 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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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-26 03:08:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 165M=0s 2016-02-26 03:08:59 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.215221 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 03:08:59.720935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 03:08:59.721231) ========= 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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.026576 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 03:08:59.769053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 03:08:59.769354) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3eb3e6986e4b34193f54618f9db800e28c10e9d3 --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 3eb3e6986e4b34193f54618f9db800e28c10e9d3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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-26 03:08:59,844 truncating revision to first 12 chars 2016-02-26 03:08:59,845 Setting DEBUG logging. 2016-02-26 03:08:59,845 attempt 1/10 2016-02-26 03:08:59,845 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3eb3e6986e4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 03:09:00,554 unpacking tar archive at: fx-team-3eb3e6986e4b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.149723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 03:09:00.934716) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 03:09:00.935037) ========= echo 3eb3e6986e4b34193f54618f9db800e28c10e9d3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3eb3e6986e4b34193f54618f9db800e28c10e9d3'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 3eb3e6986e4b34193f54618f9db800e28c10e9d3 program finished with exit code 0 elapsedTime=0.005481 script_repo_revision: '3eb3e6986e4b34193f54618f9db800e28c10e9d3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 03:09:00.986093) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 03:09:00.986422) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 03:09:01.001064) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-02-26 03:09:01.001329) ========= /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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 03:09:01 INFO - MultiFileLogger online at 20160226 03:09:01 in /builds/slave/test 03:09:01 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 03:09:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:09:01 INFO - {'append_to_log': False, 03:09:01 INFO - 'base_work_dir': '/builds/slave/test', 03:09:01 INFO - 'blob_upload_branch': 'Fx-Team', 03:09:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:09:01 INFO - 'branch': 'Fx-Team', 03:09:01 INFO - 'buildbot_json_path': 'buildprops.json', 03:09:01 INFO - 'config_files': ('talos/mac_config.py',), 03:09:01 INFO - 'default_actions': ('clobber', 03:09:01 INFO - 'read-buildbot-config', 03:09:01 INFO - 'download-and-extract', 03:09:01 INFO - 'populate-webroot', 03:09:01 INFO - 'create-virtualenv', 03:09:01 INFO - 'install', 03:09:01 INFO - 'run-tests'), 03:09:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:09:01 INFO - 'download_minidump_stackwalk': True, 03:09:01 INFO - 'download_symbols': 'ondemand', 03:09:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:09:01 INFO - 'tooltool.py': '/tools/tooltool.py', 03:09:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:09:01 INFO - '/tools/misc-python/virtualenv.py')}, 03:09:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:09:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:09:01 INFO - 'installer_path': 'installer.exe', 03:09:01 INFO - 'log_level': 'info', 03:09:01 INFO - 'log_name': 'talos', 03:09:01 INFO - 'log_to_console': True, 03:09:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:09:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:09:01 INFO - 'opt_config_files': (), 03:09:01 INFO - 'pip_index': False, 03:09:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:09:01 INFO - 'cmd': ('bash', 03:09:01 INFO - '-c', 03:09:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:09:01 INFO - 'enabled': True, 03:09:01 INFO - 'halt_on_failure': False, 03:09:01 INFO - 'name': 'check_screen_resolution'},), 03:09:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:09:01 INFO - 'cmd': ('bash', 03:09:01 INFO - '-c', 03:09:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:09:01 INFO - 'enabled': True, 03:09:01 INFO - 'halt_on_failure': False, 03:09:01 INFO - 'name': 'check_screen_resolution'},), 03:09:01 INFO - 'run_cmd_checks_enabled': True, 03:09:01 INFO - 'sps_profile': False, 03:09:01 INFO - 'sps_profile_interval': 0, 03:09:01 INFO - 'suite': 'dromaeojs-e10s', 03:09:01 INFO - 'system_bits': '32', 03:09:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:09:01 INFO - 'title': 't-yosemite-r7-0199', 03:09:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:09:01 INFO - 'use_talos_json': True, 03:09:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:09:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:09:01 INFO - 'work_dir': 'build'} 03:09:01 INFO - ##### 03:09:01 INFO - ##### Running clobber step. 03:09:01 INFO - ##### 03:09:01 INFO - Running pre-action listener: _resource_record_pre_action 03:09:01 INFO - Running main action method: clobber 03:09:01 INFO - rmtree: /builds/slave/test/build 03:09:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:09:02 INFO - Running post-action listener: _resource_record_post_action 03:09:02 INFO - ##### 03:09:02 INFO - ##### Running read-buildbot-config step. 03:09:02 INFO - ##### 03:09:02 INFO - Running pre-action listener: _resource_record_pre_action 03:09:02 INFO - Running main action method: read_buildbot_config 03:09:02 INFO - Using buildbot properties: 03:09:02 INFO - { 03:09:02 INFO - "project": "", 03:09:02 INFO - "product": "firefox", 03:09:02 INFO - "script_repo_revision": "production", 03:09:02 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 03:09:02 INFO - "repository": "", 03:09:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 03:09:02 INFO - "buildid": "20160226020723", 03:09:02 INFO - "pgo_build": "False", 03:09:02 INFO - "basedir": "/builds/slave/test", 03:09:02 INFO - "buildnumber": 421, 03:09:02 INFO - "slavename": "t-yosemite-r7-0199", 03:09:02 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:09:02 INFO - "platform": "yosemite_r7", 03:09:02 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:09:02 INFO - "branch": "fx-team", 03:09:02 INFO - "repo_path": "integration/fx-team", 03:09:02 INFO - "revision": "3eb3e6986e4b34193f54618f9db800e28c10e9d3", 03:09:02 INFO - "stage_platform": "macosx64", 03:09:02 INFO - "builduid": "26d189fe0b594ae39c2b91d88e04172c", 03:09:02 INFO - "slavebuilddir": "test" 03:09:02 INFO - } 03:09:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 03:09:02 INFO - Running post-action listener: _resource_record_post_action 03:09:02 INFO - ##### 03:09:02 INFO - ##### Running download-and-extract step. 03:09:02 INFO - ##### 03:09:02 INFO - Running pre-action listener: _resource_record_pre_action 03:09:02 INFO - Running main action method: download_and_extract 03:09:02 INFO - mkdir: /builds/slave/test/build/tests 03:09: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')]} 03:09:02 INFO - https://queue.taskcluster.net/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:09:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/test_packages.json 03:09:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/test_packages.json 03:09:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:09:11 INFO - Downloaded 1277 bytes. 03:09:11 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:09:11 INFO - Using the following test package requirements: 03:09:11 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:09:11 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:09:11 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 03:09:11 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:09:11 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 03:09:11 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:09:11 INFO - u'jsshell-mac.zip'], 03:09:11 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:09:11 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 03:09:11 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:09:11 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:09:11 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 03:09:11 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:09:11 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 03:09:11 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:09:11 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 03:09:11 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:09:11 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:09:11 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 03:09:11 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:11 INFO - https://queue.taskcluster.net/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:09:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:09:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:09:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/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 03:09:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/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 03:09:18 INFO - Downloaded 17830412 bytes. 03:09:18 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'] 03:09:18 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 03:09:21 INFO - Return code: 0 03:09:21 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 03:09:21 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')]} 03:09:21 INFO - https://queue.taskcluster.net/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:09:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:09:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:09:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/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 03:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/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 03:09:22 INFO - Downloaded 17830412 bytes. 03:09:22 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'] 03:09:22 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 03:09:26 INFO - Return code: 0 03:09:26 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')]} 03:09:26 INFO - https://queue.taskcluster.net/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:09:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:09:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:09:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/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 03:09:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/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 03:09:27 INFO - Downloaded 10713410 bytes. 03:09:27 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'] 03:09:27 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 03:09:27 INFO - Return code: 0 03:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:27 INFO - https://queue.taskcluster.net/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:09:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:09:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:09:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 03:09:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MhjeGgKEQuWx-o7opuL9Wg/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 03:09:35 INFO - Downloaded 111442770 bytes. 03:09:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:09:35 INFO - mkdir: /builds/slave/test/properties 03:09:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:09:35 INFO - Writing to file /builds/slave/test/properties/build_url 03:09:35 INFO - Contents: 03:09:35 INFO - build_url:https://queue.taskcluster.net/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:09:35 INFO - Running post-action listener: _resource_record_post_action 03:09:35 INFO - Running post-action listener: set_extra_try_arguments 03:09:35 INFO - ##### 03:09:35 INFO - ##### Running populate-webroot step. 03:09:35 INFO - ##### 03:09:35 INFO - Running pre-action listener: _resource_record_pre_action 03:09:35 INFO - Running main action method: populate_webroot 03:09:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:09:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:09:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:09:35 INFO - '--tppagecycles', 03:09:35 INFO - '7'], 03:09:35 INFO - 'tests': ['tsvgm']}}, 03:09:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:09:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:09:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:09:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:09:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:09:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:09:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:35 INFO - 'talos_options': ['--e10s'], 03:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:35 INFO - 'tests': ['damp', 'tps']}, 03:09:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:35 INFO - 'talos_options': ['--e10s'], 03:09:35 INFO - 'tests': ['damp', 'tps']}, 03:09:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:09:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:09:35 INFO - 'other': {'tests': ['a11yr', 03:09:35 INFO - 'ts_paint', 03:09:35 INFO - 'tpaint', 03:09:35 INFO - 'sessionrestore', 03:09:35 INFO - 'sessionrestore_no_auto_restore']}, 03:09:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:09:35 INFO - 'tests': ['a11yr', 03:09:35 INFO - 'ts_paint', 03:09:35 INFO - 'tpaint', 03:09:35 INFO - 'sessionrestore', 03:09:35 INFO - 'sessionrestore_no_auto_restore']}, 03:09:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:09:35 INFO - 'tests': ['a11yr', 03:09:35 INFO - 'ts_paint', 03:09:35 INFO - 'tpaint', 03:09:35 INFO - 'sessionrestore', 03:09:35 INFO - 'sessionrestore_no_auto_restore']}, 03:09:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:09:35 INFO - 'tests': ['a11yr', 03:09:35 INFO - 'ts_paint', 03:09:35 INFO - 'tpaint', 03:09:35 INFO - 'sessionrestore', 03:09:35 INFO - 'sessionrestore_no_auto_restore']}, 03:09:35 INFO - 'other_l64': {'tests': ['a11yr', 03:09:35 INFO - 'ts_paint', 03:09:35 INFO - 'tpaint', 03:09:35 INFO - 'sessionrestore', 03:09:35 INFO - 'sessionrestore_no_auto_restore']}, 03:09:35 INFO - 'other_nol64': {'tests': ['a11yr', 03:09:35 INFO - 'ts_paint', 03:09:35 INFO - 'tpaint', 03:09:35 INFO - 'sessionrestore', 03:09:35 INFO - 'sessionrestore_no_auto_restore']}, 03:09:35 INFO - 'svgr': {'tests': ['tsvgx', 03:09:35 INFO - 'tsvgr_opacity', 03:09:35 INFO - 'tart', 03:09:35 INFO - 'tscrollx', 03:09:35 INFO - 'cart']}, 03:09:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:09:35 INFO - 'tests': ['tsvgx', 03:09:35 INFO - 'tsvgr_opacity', 03:09:35 INFO - 'tart', 03:09:35 INFO - 'tscrollx', 03:09:35 INFO - 'cart']}, 03:09:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:35 INFO - 'tests': ['tp5o']}, 03:09:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:35 INFO - 'talos_options': ['--e10s'], 03:09:35 INFO - 'tests': ['tp5o']}, 03:09:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:35 INFO - 'talos_options': ['--xperf_path', 03:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:35 INFO - 'tests': ['tp5n']}, 03:09:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:35 INFO - 'talos_options': ['--e10s', 03:09:35 INFO - '--xperf_path', 03:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:35 INFO - 'tests': ['tp5n']}}, 03:09:35 INFO - 'talos.zip': {'path': '', 03:09:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:09:35 INFO - Running post-action listener: _resource_record_post_action 03:09:35 INFO - ##### 03:09:35 INFO - ##### Running create-virtualenv step. 03:09:35 INFO - ##### 03:09:35 INFO - Running pre-action listener: _resource_record_pre_action 03:09:35 INFO - Running main action method: create_virtualenv 03:09:35 INFO - Creating virtualenv /builds/slave/test/build/venv 03:09:35 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 03:09:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:09:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:09:36 INFO - Using real prefix '/tools/python27' 03:09:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:09:36 INFO - Installing distribute.............................................................................................................................................................................................done. 03:09:39 INFO - Installing pip.................done. 03:09:39 INFO - Return code: 0 03:09:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:09:39 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')]} 03:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:39 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')]} 03:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:39 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 0x10a2d5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c0d5deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a179d30>, '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 0x109f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a170b20>, '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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 03:09:39 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 03:09:39 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 03:09:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2YIVvUKfZ3/Render', 03:09:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:39 INFO - 'HOME': '/Users/cltbld', 03:09:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:39 INFO - 'LOGNAME': 'cltbld', 03:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:39 INFO - 'MOZ_NO_REMOTE': '1', 03:09:39 INFO - 'NO_EM_RESTART': '1', 03:09:39 INFO - 'PAGER': '/bin/cat', 03:09:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:39 INFO - 'PWD': '/builds/slave/test', 03:09:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:39 INFO - 'SHELL': '/bin/bash', 03:09:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bzzwCiKUMI/Listeners', 03:09:39 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 03:09:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:39 INFO - 'USER': 'cltbld', 03:09:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:39 INFO - 'XPC_FLAGS': '0x0', 03:09:39 INFO - 'XPC_SERVICE_NAME': '0', 03:09:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:39 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 03:09:39 INFO - Cleaning up... 03:09:39 INFO - Return code: 0 03:09:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:09:39 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')]} 03:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:39 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')]} 03:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:39 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 0x10a2d5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c0d5deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a179d30>, '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 0x109f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a170b20>, '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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 03:09:39 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 03:09:39 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 03:09:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2YIVvUKfZ3/Render', 03:09:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:39 INFO - 'HOME': '/Users/cltbld', 03:09:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:39 INFO - 'LOGNAME': 'cltbld', 03:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:39 INFO - 'MOZ_NO_REMOTE': '1', 03:09:39 INFO - 'NO_EM_RESTART': '1', 03:09:39 INFO - 'PAGER': '/bin/cat', 03:09:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:39 INFO - 'PWD': '/builds/slave/test', 03:09:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:39 INFO - 'SHELL': '/bin/bash', 03:09:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bzzwCiKUMI/Listeners', 03:09:39 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 03:09:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:39 INFO - 'USER': 'cltbld', 03:09:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:39 INFO - 'XPC_FLAGS': '0x0', 03:09:39 INFO - 'XPC_SERVICE_NAME': '0', 03:09:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:40 INFO - Downloading/unpacking psutil>=0.7.1 03:09:40 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 03:09:40 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 03:09:40 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 03:09:40 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 03:09:40 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 03:09:40 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 03:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:09:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:43 INFO - Installing collected packages: psutil 03:09:43 INFO - Running setup.py install for psutil 03:09:43 INFO - building 'psutil._psutil_osx' extension 03:09:43 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 03:09:44 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 03:09:44 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 03:09:44 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 03:09:44 INFO - building 'psutil._psutil_posix' extension 03:09:44 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 03:09:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:09:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:09:44 INFO - ^ 03:09:44 INFO - 1 warning generated. 03:09:44 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 03:09:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:44 INFO - Successfully installed psutil 03:09:44 INFO - Cleaning up... 03:09:44 INFO - Return code: 0 03:09:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:44 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 0x10a2d5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c0d5deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a179d30>, '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 0x109f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a170b20>, '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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 03:09:44 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 03:09:44 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 03:09:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2YIVvUKfZ3/Render', 03:09:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:44 INFO - 'HOME': '/Users/cltbld', 03:09:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:44 INFO - 'LOGNAME': 'cltbld', 03:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:44 INFO - 'MOZ_NO_REMOTE': '1', 03:09:44 INFO - 'NO_EM_RESTART': '1', 03:09:44 INFO - 'PAGER': '/bin/cat', 03:09:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:44 INFO - 'PWD': '/builds/slave/test', 03:09:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:44 INFO - 'SHELL': '/bin/bash', 03:09:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bzzwCiKUMI/Listeners', 03:09:44 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 03:09:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:44 INFO - 'USER': 'cltbld', 03:09:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:44 INFO - 'XPC_FLAGS': '0x0', 03:09:44 INFO - 'XPC_SERVICE_NAME': '0', 03:09:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:09:47 INFO - Installing collected packages: mozsystemmonitor 03:09:47 INFO - Running setup.py install for mozsystemmonitor 03:09:47 INFO - Successfully installed mozsystemmonitor 03:09:47 INFO - Cleaning up... 03:09:47 INFO - Return code: 0 03:09:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:47 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 0x10a2d5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c0d5deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a179d30>, '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 0x109f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a170b20>, '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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 03:09:47 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 03:09:47 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 03:09:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2YIVvUKfZ3/Render', 03:09:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:47 INFO - 'HOME': '/Users/cltbld', 03:09:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:47 INFO - 'LOGNAME': 'cltbld', 03:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:47 INFO - 'MOZ_NO_REMOTE': '1', 03:09:47 INFO - 'NO_EM_RESTART': '1', 03:09:47 INFO - 'PAGER': '/bin/cat', 03:09:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:47 INFO - 'PWD': '/builds/slave/test', 03:09:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:47 INFO - 'SHELL': '/bin/bash', 03:09:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bzzwCiKUMI/Listeners', 03:09:47 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 03:09:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:47 INFO - 'USER': 'cltbld', 03:09:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:47 INFO - 'XPC_FLAGS': '0x0', 03:09:47 INFO - 'XPC_SERVICE_NAME': '0', 03:09:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:47 INFO - Downloading/unpacking blobuploader==1.2.4 03:09:47 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 03:09:47 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 03:09:47 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 03:09:47 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 03:09:47 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 03:09:47 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 03:09:50 INFO - Downloading blobuploader-1.2.4.tar.gz 03:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:09:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:09:50 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 03:09:50 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 03:09:50 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 03:09:50 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 03:09:50 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 03:09:50 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 03:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:09:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:09:50 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 03:09:50 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 03:09:50 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 03:09:50 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 03:09:50 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 03:09:50 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 03:09:51 INFO - Downloading docopt-0.6.1.tar.gz 03:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:09:51 INFO - Installing collected packages: blobuploader, requests, docopt 03:09:51 INFO - Running setup.py install for blobuploader 03:09:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:09:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:09:51 INFO - Running setup.py install for requests 03:09:52 INFO - Running setup.py install for docopt 03:09:52 INFO - Successfully installed blobuploader requests docopt 03:09:52 INFO - Cleaning up... 03:09:52 INFO - Return code: 0 03:09:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:52 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')]} 03:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:52 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')]} 03:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:52 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 0x10a2d5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c0d5deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a179d30>, '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 0x109f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a170b20>, '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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 03:09:52 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 03:09:52 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 03:09:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2YIVvUKfZ3/Render', 03:09:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:52 INFO - 'HOME': '/Users/cltbld', 03:09:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:52 INFO - 'LOGNAME': 'cltbld', 03:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:52 INFO - 'MOZ_NO_REMOTE': '1', 03:09:52 INFO - 'NO_EM_RESTART': '1', 03:09:52 INFO - 'PAGER': '/bin/cat', 03:09:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:52 INFO - 'PWD': '/builds/slave/test', 03:09:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:52 INFO - 'SHELL': '/bin/bash', 03:09:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bzzwCiKUMI/Listeners', 03:09:52 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 03:09:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:52 INFO - 'USER': 'cltbld', 03:09:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:52 INFO - 'XPC_FLAGS': '0x0', 03:09:52 INFO - 'XPC_SERVICE_NAME': '0', 03:09:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:52 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-bZaq01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:52 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-WkQfgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:52 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-mfVHhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:52 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-KTN3Ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:52 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-72GvC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:53 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-t3SzHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:53 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-eCAXfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:53 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-LKvYOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:53 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-MlnQcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:53 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-189rLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:53 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-QPSds0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:53 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Zuljto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:53 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-E5bhLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:53 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-fs3PN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:54 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-4wr4Pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:54 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-nqsQaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:54 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Aif0tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:09:54 INFO - Running setup.py install for manifestparser 03:09:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:09:54 INFO - Running setup.py install for mozcrash 03:09:54 INFO - Running setup.py install for mozdebug 03:09:54 INFO - Running setup.py install for mozdevice 03:09:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:09:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:09:54 INFO - Running setup.py install for mozfile 03:09:55 INFO - Running setup.py install for mozhttpd 03:09:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:09:55 INFO - Running setup.py install for mozinfo 03:09:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:09:55 INFO - Running setup.py install for mozInstall 03:09:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:09:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:09:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:09:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:09:55 INFO - Running setup.py install for mozleak 03:09:55 INFO - Running setup.py install for mozlog 03:09:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:09:55 INFO - Running setup.py install for moznetwork 03:09:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:09:55 INFO - Running setup.py install for mozprocess 03:09:56 INFO - Running setup.py install for mozprofile 03:09:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:09:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:09:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:09:56 INFO - Running setup.py install for mozrunner 03:09:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:09:56 INFO - Running setup.py install for mozscreenshot 03:09:56 INFO - Running setup.py install for moztest 03:09:56 INFO - Running setup.py install for mozversion 03:09:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:09:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:09:56 INFO - Cleaning up... 03:09:56 INFO - Return code: 0 03:09:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:56 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')]} 03:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:56 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')]} 03:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:56 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 0x10a2d5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c0d5deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a179d30>, '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 0x109f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a170b20>, '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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 03:09:56 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 03:09:56 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 03:09:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2YIVvUKfZ3/Render', 03:09:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:56 INFO - 'HOME': '/Users/cltbld', 03:09:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:56 INFO - 'LOGNAME': 'cltbld', 03:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:56 INFO - 'MOZ_NO_REMOTE': '1', 03:09:56 INFO - 'NO_EM_RESTART': '1', 03:09:56 INFO - 'PAGER': '/bin/cat', 03:09:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:56 INFO - 'PWD': '/builds/slave/test', 03:09:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:56 INFO - 'SHELL': '/bin/bash', 03:09:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bzzwCiKUMI/Listeners', 03:09:56 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 03:09:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:56 INFO - 'USER': 'cltbld', 03:09:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:56 INFO - 'XPC_FLAGS': '0x0', 03:09:56 INFO - 'XPC_SERVICE_NAME': '0', 03:09:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:57 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-a_D99W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:57 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)) 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:57 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-gZUFli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:57 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)) 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:57 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-vZ3P3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:57 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)) 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:57 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-pjJTG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:57 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)) 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:57 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-eU5C_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:57 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)) 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:57 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-QTPVWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:57 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)) 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:57 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-9ntQqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:57 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)) 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:57 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-fvRfIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:57 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)) 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:57 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-sSkV6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:58 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)) 03:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:58 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-RD11Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:58 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)) 03:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:58 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-SdiXHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:58 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)) 03:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:58 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-iQP9ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:58 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)) 03:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:58 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-eFU94J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:58 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)) 03:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:58 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-C6Yten-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:58 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)) 03:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:58 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-CE6r0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:58 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)) 03:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:58 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-9ojNto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:58 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)) 03:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:58 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-zp4Hk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:58 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)) 03:09:58 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)) 03:09:58 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)) 03:09:58 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)) 03:09:58 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)) 03:09:58 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)) 03:09:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03: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 03: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 03: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 03: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 03: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 03: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 03:10:01 INFO - Downloading blessings-1.6.tar.gz 03:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:10:01 INFO - Installing collected packages: blessings 03:10:01 INFO - Running setup.py install for blessings 03:10:01 INFO - Successfully installed blessings 03:10:01 INFO - Cleaning up... 03:10:01 INFO - Return code: 0 03:10:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:10:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:01 INFO - Reading from file tmpfile_stdout 03:10:01 INFO - Current package versions: 03:10:01 INFO - blessings == 1.6 03:10:01 INFO - blobuploader == 1.2.4 03:10:01 INFO - docopt == 0.6.1 03:10:01 INFO - manifestparser == 1.1 03:10:01 INFO - mozInstall == 1.12 03:10:01 INFO - mozcrash == 0.16 03:10:01 INFO - mozdebug == 0.1 03:10:01 INFO - mozdevice == 0.48 03:10:01 INFO - mozfile == 1.2 03:10:01 INFO - mozhttpd == 0.7 03:10:01 INFO - mozinfo == 0.9 03:10:01 INFO - mozleak == 0.1 03:10:01 INFO - mozlog == 3.1 03:10:01 INFO - moznetwork == 0.27 03:10:01 INFO - mozprocess == 0.22 03:10:01 INFO - mozprofile == 0.28 03:10:01 INFO - mozrunner == 6.11 03:10:01 INFO - mozscreenshot == 0.1 03:10:01 INFO - mozsystemmonitor == 0.0 03:10:01 INFO - moztest == 0.7 03:10:01 INFO - mozversion == 1.4 03:10:01 INFO - psutil == 3.1.1 03:10:01 INFO - requests == 1.2.3 03:10:01 INFO - wsgiref == 0.1.2 03:10:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:01 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 0x10a2d5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c0d5deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a179d30>, '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 0x109f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a170b20>, '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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 03:10:01 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 03:10:01 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 03:10:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2YIVvUKfZ3/Render', 03:10:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:01 INFO - 'HOME': '/Users/cltbld', 03:10:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:01 INFO - 'LOGNAME': 'cltbld', 03:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:01 INFO - 'MOZ_NO_REMOTE': '1', 03:10:01 INFO - 'NO_EM_RESTART': '1', 03:10:01 INFO - 'PAGER': '/bin/cat', 03:10:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:01 INFO - 'PWD': '/builds/slave/test', 03:10:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:01 INFO - 'SHELL': '/bin/bash', 03:10:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bzzwCiKUMI/Listeners', 03:10:01 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 03:10:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:01 INFO - 'USER': 'cltbld', 03:10:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:01 INFO - 'XPC_FLAGS': '0x0', 03:10:01 INFO - 'XPC_SERVICE_NAME': '0', 03:10:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:02 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)) 03:10:02 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)) 03:10:02 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)) 03:10:02 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)) 03:10:02 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)) 03:10:02 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)) 03:10:02 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)) 03:10:02 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)) 03:10:02 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)) 03:10:02 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)) 03:10:02 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)) 03:10:02 INFO - Cleaning up... 03:10:02 INFO - Return code: 0 03:10:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03: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')]} 03:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2d5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c0d5deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a179d30>, '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 0x109f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a170b20>, '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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 03: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', 'jsonschema'] in /builds/slave/test/build 03: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 jsonschema 03:10:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2YIVvUKfZ3/Render', 03:10:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:02 INFO - 'HOME': '/Users/cltbld', 03:10:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:02 INFO - 'LOGNAME': 'cltbld', 03:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:02 INFO - 'MOZ_NO_REMOTE': '1', 03:10:02 INFO - 'NO_EM_RESTART': '1', 03:10:02 INFO - 'PAGER': '/bin/cat', 03:10:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:02 INFO - 'PWD': '/builds/slave/test', 03:10:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:02 INFO - 'SHELL': '/bin/bash', 03:10:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bzzwCiKUMI/Listeners', 03:10:02 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 03:10:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:02 INFO - 'USER': 'cltbld', 03:10:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:02 INFO - 'XPC_FLAGS': '0x0', 03:10:02 INFO - 'XPC_SERVICE_NAME': '0', 03:10:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:02 INFO - Downloading/unpacking jsonschema 03: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 03:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03: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 03:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:10:04 INFO - Downloading/unpacking functools32 (from jsonschema) 03:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:05 INFO - Downloading functools32-3.2.3-2.tar.gz 03:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:10:05 INFO - warning: no files found matching '*.txt' 03:10:05 INFO - no previously-included directories found matching 'build' 03:10:05 INFO - no previously-included directories found matching 'dist' 03:10:05 INFO - no previously-included directories found matching '.git*' 03:10:05 INFO - Installing collected packages: jsonschema, functools32 03:10:05 INFO - Running setup.py install for functools32 03:10:05 INFO - warning: no files found matching '*.txt' 03:10:05 INFO - no previously-included directories found matching 'build' 03:10:05 INFO - no previously-included directories found matching 'dist' 03:10:05 INFO - no previously-included directories found matching '.git*' 03:10:05 INFO - Successfully installed jsonschema functools32 03:10:05 INFO - Cleaning up... 03:10:05 INFO - Return code: 0 03:10:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2d5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c0d5deb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a179d30>, '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 0x109f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a170b20>, '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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 03: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', 'flake8'] in /builds/slave/test/build 03: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 flake8 03:10:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2YIVvUKfZ3/Render', 03:10:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:05 INFO - 'HOME': '/Users/cltbld', 03:10:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:05 INFO - 'LOGNAME': 'cltbld', 03:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:05 INFO - 'MOZ_NO_REMOTE': '1', 03:10:05 INFO - 'NO_EM_RESTART': '1', 03:10:05 INFO - 'PAGER': '/bin/cat', 03:10:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:05 INFO - 'PWD': '/builds/slave/test', 03:10:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:05 INFO - 'SHELL': '/bin/bash', 03:10:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bzzwCiKUMI/Listeners', 03:10:05 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 03:10:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:05 INFO - 'USER': 'cltbld', 03:10:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:05 INFO - 'XPC_FLAGS': '0x0', 03:10:05 INFO - 'XPC_SERVICE_NAME': '0', 03:10:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:06 INFO - Downloading/unpacking flake8 03:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:10:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03: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 03: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 03: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 03: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 03: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 03: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 03:10:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:10:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03: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 03: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 03: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 03: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 03: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 03: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 03:10:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:10:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:10:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:10:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:10:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:10:09 INFO - no previously-included directories found matching 'docs/_build' 03:10:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:10:09 INFO - Running setup.py install for pep8 03:10:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:10:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:10:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:10:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:10:09 INFO - no previously-included directories found matching 'docs/_build' 03:10:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:10:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:10:09 INFO - Cleaning up... 03:10:10 INFO - Return code: 0 03:10:10 INFO - Running post-action listener: _resource_record_post_action 03:10:10 INFO - Running post-action listener: _start_resource_monitoring 03:10:10 INFO - Starting resource monitoring. 03:10:10 INFO - ##### 03:10:10 INFO - ##### Running install step. 03:10:10 INFO - ##### 03:10:10 INFO - Running pre-action listener: _resource_record_pre_action 03:10:10 INFO - Running main action method: install 03:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:10 INFO - Reading from file tmpfile_stdout 03:10:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:10:10 INFO - Reading from file tmpfile_stdout 03:10:10 INFO - Output received: 03:10:10 INFO - Usage: mozinstall [options] installer 03:10:10 INFO - Options: 03:10:10 INFO - -h, --help show this help message and exit 03:10:10 INFO - -d DEST, --destination=DEST 03:10:10 INFO - Directory to install application into. [default: 03:10:10 INFO - "/builds/slave/test"] 03:10:10 INFO - --app=APP Application being installed. [default: firefox] 03:10:10 INFO - mkdir: /builds/slave/test/build/application 03:10:10 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'] 03:10:10 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 03:10:44 INFO - Reading from file tmpfile_stdout 03:10:44 INFO - Output received: 03:10:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:10:44 INFO - Running post-action listener: _resource_record_post_action 03:10:44 INFO - ##### 03:10:44 INFO - ##### Running run-tests step. 03:10:44 INFO - ##### 03:10:44 INFO - Running pre-action listener: _resource_record_pre_action 03:10:44 INFO - Running main action method: run_tests 03:10:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:10:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:10:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:10:44 INFO - 2016-02-26 03:10:44.530 screenresolution[1659:8149] starting screenresolution argv=screenresolution get 03:10:44 INFO - 2016-02-26 03:10:44.532 screenresolution[1659:8149] Display 0: 1600x1200x32@60 03:10:44 INFO - 2016-02-26 03:10:44.538 screenresolution[1660:8152] starting screenresolution argv=screenresolution list 03:10:44 INFO - Available Modes on Display 0 03:10:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:10:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:10:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:10:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:10:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:10:44 INFO - Intel Iris: 03:10:44 INFO - Chipset Model: Intel Iris 03:10:44 INFO - Type: GPU 03:10:44 INFO - Bus: Built-In 03:10:44 INFO - VRAM (Dynamic, Max): 1536 MB 03:10:44 INFO - Vendor: Intel (0x8086) 03:10:44 INFO - Device ID: 0x0a2e 03:10:44 INFO - Revision ID: 0x0009 03:10:44 INFO - Displays: 03:10:44 INFO - Display: 03:10:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:10:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:10:44 INFO - Display Serial Number: 1600x1200 60 03:10:44 INFO - Main Display: Yes 03:10:44 INFO - Mirror: Off 03:10:44 INFO - Online: Yes 03:10:44 INFO - Rotation: Supported 03:10:44 INFO - Return code: 0 03:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:10:44 INFO - Python 2.7.3 03:10:44 INFO - Return code: 0 03:10:44 INFO - grabbing minidump binary from tooltool 03:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:44 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 0x10a179d30>, '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 0x109f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a170b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:10:44 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 03:10:44 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 03:10:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:10:44 INFO - Return code: 0 03:10:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:10:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:10:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:10:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:10:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:10:46 INFO - Return code: 0 03:10:46 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/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0199', '--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 03:10:46 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/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0199 --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 03:10:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2YIVvUKfZ3/Render', 03:10:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:46 INFO - 'HOME': '/Users/cltbld', 03:10:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:46 INFO - 'LOGNAME': 'cltbld', 03:10:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:10:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:46 INFO - 'MOZ_NO_REMOTE': '1', 03:10:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:10:46 INFO - 'NO_EM_RESTART': '1', 03:10:46 INFO - 'PAGER': '/bin/cat', 03:10:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:46 INFO - 'PWD': '/builds/slave/test', 03:10:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:10:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:46 INFO - 'SHELL': '/bin/bash', 03:10:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bzzwCiKUMI/Listeners', 03:10:46 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 03:10:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:46 INFO - 'USER': 'cltbld', 03:10:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:46 INFO - 'XPC_FLAGS': '0x0', 03:10:46 INFO - 'XPC_SERVICE_NAME': '0', 03:10:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:46 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/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0199', '--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 03:10:46 INFO - mozversion application_buildid: 20160226020723 03:10:46 INFO - mozversion application_changeset: 3eb3e6986e4b34193f54618f9db800e28c10e9d3 03:10:46 INFO - mozversion application_display_name: Nightly 03:10:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:10:46 INFO - mozversion application_name: Firefox 03:10:46 INFO - mozversion application_remotingname: firefox 03:10:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:10:46 INFO - mozversion application_vendor: Mozilla 03:10:46 INFO - mozversion application_version: 47.0a1 03:10:46 INFO - mozversion platform_buildid: 20160226020723 03:10:46 INFO - mozversion platform_changeset: 3eb3e6986e4b34193f54618f9db800e28c10e9d3 03:10:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:10:46 INFO - mozversion platform_version: 47.0a1 03:10:46 INFO - using testdate: 1456485046 03:10:46 INFO - actual date: 1456485046 03:10:46 INFO - starting webserver on 'localhost:49276' 03:10:46 INFO - SUITE-START | Running 2 tests 03:10:46 INFO - TEST-START | dromaeo_css 03:10:46 INFO - operating with platform_type : mac_ 03:10:46 INFO - Initialising browser for dromaeo_css test... 03:10:46 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmplrrZtc/profile http://localhost:49276/getInfo.html) 03:10:49 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 03:10:49 INFO - PROCESS | 1678 | colorDepth:24 03:10:49 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 03:10:49 INFO - PROCESS | 1678 | __metrics 03:10:49 ERROR - PROCESS | 1678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:10:50 INFO - TEST-INFO | 1678: exit 0 03:10:50 INFO - Browser initialized. 03:10:50 INFO - Running cycle 1/1 for dromaeo_css test... 03:10:50 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmplrrZtc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:02 INFO - PROCESS | 1683 | RSS: Main: 256040960 03:11:02 INFO - PROCESS | 1683 | 03:11:51 INFO - PROCESS | 1683 | 1456485111835 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] 03:14:02 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 03:14:03 INFO - PROCESS | 1683 | RSS: Main: 269856768 03:14:03 INFO - PROCESS | 1683 | 03:17:05 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 03:17:06 INFO - PROCESS | 1683 | RSS: Main: 280997888 03:17:06 INFO - PROCESS | 1683 | 03:20:07 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 03:20:08 INFO - PROCESS | 1683 | RSS: Main: 283090944 03:20:08 INFO - PROCESS | 1683 | 03:23:10 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 03:23:10 INFO - PROCESS | 1683 | RSS: Main: 283308032 03:23:10 INFO - PROCESS | 1683 | 03:26:13 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 03:26:13 INFO - PROCESS | 1683 | RSS: Main: 285896704 03:26:13 INFO - PROCESS | 1683 | 03:29:16 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 03:29:16 INFO - PROCESS | 1683 | RSS: Main: 289050624 03:29:16 INFO - PROCESS | 1683 | 03:29:16 INFO - PROCESS | 1683 | __start_tp_report 03:29:16 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 03:29:16 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 03:29:16 INFO - PROCESS | 1683 | |i|pagename|runs| 03:29:16 INFO - PROCESS | 1683 | |0;dojo.html;3490.3019396120776;3531.999999999998;3555.5733312002562;3587.1928816016393;3593.5508061492314;5692.800751973682;5716.914246286309;5732.885342293152;5733.827985160441;5818.476337129658;5678.971605141968;5706.486416222539;5804.738786754596;5811.941880581193;5943.375945525722;5154.381474223089;5194.974025129888;5217.295665085203;5251.10731175701;5272.393674727398;5204.42751297357;5216.947830521684;5273.419923808378;5275.841724748264;5280.128778751501;5105.3873535175835;5131.332926719521;5210.895782084375;5212.139996900545;5219.660722053054;5178.275041494194;5194.142966410538;5194.246834209056;5205.869853253661;5247.2129180623215;5018.046571151506;5138.948610513884;5159.329287192679;5161.638685292031;5191.299174611455;5377.843763590808;5469.206964990054;5626.887462250732;5669.8582535436535;5688.914666280009;6230.719617617173;6255.9364907965755;6259.311475737711;6259.87480250397;6299.275583307933;6126.456603435073;6174.691265436755;6196.411340922605;6225.097360882692;6246.440098727954;5803.245578074865;5805.071188609802;5808.82573522795;5815.738291776795;5829.621074630136;4965.553100220997;5271.156614941591;6178.938210617926;6251.562390632612;6289.905651415233;5041.6722913010535;6042.818715438544;6113.32753397126;6114.844865410725;6124.724387402578;6079.331273559905;6132.202813634199;6173.259208894961;6217.316095229521;6226.439620434183;5290.65610735301;6201.6899155042065;6236.438720515175;6244.594101383486;6244.718987645567;5735.996200664867;5828.766849326064;6144.8771024580155;6262.185915830913;6279.152314437492;4838.395200599925;4869.63477739171;4888.095702295087;4909.70541767488;4932.975335123373;4398.164348773723;4402.273624851928;4405.008873003549;4408.448943882015;4461.7992190351515;5659.801906933238;5672.461116193955;5688.744006519716;5692.8861422771315;5793.188953546507;6221.657808820468;6223.844403889939;6233;6250.124982502453;6275.937240627535;5691.9715401423555;5757.136429535603;5772.278465191851;5790.276215473066;5805.796797112081;5340.332458442695;5376.865578360573;5381.0583147948955;5390.51485366319;5423.674579525241;6236.719347629368;6238.500919926395;6258.061290806416;6273.65494897785;6282.842928926813;6127.0062805303205;6154.753809847556;6211.378862113753;6225.719842607185;6251.749930002931;6198.876022479615;6270.216222972129;6275.780347687809;6277.403646653561;6284.057391391328;6123.479504242189;6174.228221472316;6195.4424101829245;6214.782482613087;6228.190335256388;6137.202163718866;6161.199044124235;6174.6912654368;6260.906086408617;6261.530385221035;5838.3869693683255;6082.2093127893095;6089.817305480843;6112.663803490673;6159.5688301818445;5907.409259074058;6071.878562428638;6091.512678985582;6110.572259941761;6129.601575897553;5769.9711501442225;5805.622634528742;5908.231929849092;5952.0476723724;5956.523478121827;6120.08198770188;6134.539909506716;6136.969315153396;6138.048602466625;6174.783882564268;6039;6040.697965101639;6045.002574575145;6048.818535443944;6075.2405949256345 03:29:16 INFO - PROCESS | 1683 | |1;ext.html;454.5636189258312;466.553683580899;525.8685328667833;553.4907884746033;561.7079118858196;32666;37233.882983510535;37256.627433725655;37327.06682332943;37538.436923446134;32371.352572948526;37850.24299514008;38472.03819904504;38564.80717596415;38596.421053684215;8306.08633050364;9260.583273752698;9400.764980875465;9402.670906518273;9408.623655053789;9407.52962351883;9630.277729170306;9635.277354198428;9659.903400966006;9703.854442183372;9559.187469065138;9587.712368628918;9595.616175352978;9626.326157169002;9671.419714817099;8457;9568.37805542641;9586.808263834719;9650.806983860284;9652.613895444174;8372;8870.778230544223;9213.170814626716;9493.525323733855;9606.9519652402;38275.425868611994;38461.03847403809;38529;38552.61447385518;38575.8071209645;3189.9202519936957;3204.102851201644;3213.839308034589;3350.5309256703836;3385.4414021686393;26434.074807381843;28108.437831243464;28199;28419;28566.428671426664;2543.605741110131;2768.3632764464287;2784.1647505748397;2865.126136528358;2877.6690680571583;359473;359514;361160;361195;480668;62643.373566263755;62834.37165628285;62931.685341573;63005.68497157576;63028;60454.69772651108;65203.021954670716;70384.29615703778;71260;71380;13673.863261367458;16064.598385040234;16074.919625401799;16201.918990404973;16273.267702953395;12319.75360492803;12321.753564928831;12374.443150058269;12417.813732794015;12486.063545234143;20301.695474567892;20487.38537843867;20590.176392944115;20642.690359644617;20670.17319307241;8845.292376609856;9044.728658140266;9057.81884362309;9065.365424420359;9102.31732620043;894.561664784264;922.935394522377;1027.2655051638114;1053.5311786255043;1086.8369744538381;28988.42023159525;29037.709622903923;29058.547072646285;29579.26051848678;29645.85177074144;942.7218970403748;1111.3109871879487;1127.2841745491671;1179.6402097360217;1188.1267268557604;14731.558053258204;14983.32575034126;14993.400263989319;14998.025128366622;15076.944613876924;529897;530573;533415;534307;536289;56544.71727641418;56740;56745.43254567401;56898.57753556111;56996.57508562319;1340.3968214303602;1341.6645838540364;1344.7512210241136;1387.4450219912117;1388.7916812478209;27827.16518504448;27874;28667;28986;29302.853485732434;49390;49404.50595494143;49748.50251497439;49809;49836;462605;463743;467073;469366;469871;32511.67488325181;41656;43180.78409607932;43342.133157336044;43483;45036.54963450324;45797.77101114473;46142.76928615336;46154.76922615366;46403;35075.29849402946;35317;35597.64402356047;35990.4601430984;36063.27873442569;34846;35826.820865895505;35979.28041439209;36348.818255908554;36666.083347916516;31980.040598782074;36998.44502332521;37282.254354912206;37462.43806342962;38443;30796.23009424782;31464.685353146175;31489.685103148677;31538.526922096647;31674.366512669156;18667.439976800717;23340.53318933578;24014.63978040296;24151.879240604387;24441.87779061093 03:29:16 INFO - PROCESS | 1683 | |2;jquery.html;346.2192755336715;353.2704964248826;357.50307073168284;357.94272916333387;359.80031082749065;18539.07304634768;18804.34184803532;19196;19486.317978870742;19513.219471221135;14426.927865360685;17702.67229957752;19397.806021939778;20537.178512859504;20689.275875344367;5596.972015139919;5876.118582212681;5927.140564618127;5935.465808077272;5944.2866855977345;4169.374593810938;5742.79900203493;6209.720562574673;6516;6522.641254730988;6003.249593800775;6065.878682426349;6430.871382572346;6440.967795161017;6497.93502064978;6153.35389784073;6402.199725034371;6404.455621272197;6427.325130861263;6430.356964303555;5318.654287471302;5522.8678120985505;5528.5024347808485;5539.8892022159735;5548.77804887804;12536;13173.209607423489;24323.87838060816;24424.87787561051;24462.388440288956;1997.7203191553194;2020.6160829442358;2123.6389813731703;2232.2410380470556;2497.5629264878576;9853;9942.502874856229;10554.577816887315;12043.976262017739;14567.271636418136;1652.6694661067713;1666.067002478616;1722.5607470095047;1738.0701324791303;1753.7018706819872;107653;111796.44101779521;112180;113328;113477.29784053164;11338.716532086599;11523.884761152449;11583.710407239718;11611.76776464466;11668.94165529167;13805.51680691171;13859.237741924291;13866.791998120036;13873.236971966437;13900;8260.215279548433;8420.452670576393;8430.114837941928;8508.106648801786;8509.425756235116;7778.299953004257;8466.661333546712;8530.232279094911;8595.269402100766;8604.48373097616;4358.956410435919;4470.754108524063;4480.327950807405;4496.5503449655425;4497.955020449819;1737.869659775522;1812.7915289741848;1855.3135339924315;1870.5978214683907;1893.9337123200899;883.9204471597459;956.8660387545749;957.593022965237;962.1484985787629;994.3834822410007;18947.336843210698;19909;19910.701339479918;19953.60092798165;20220;951.8143961927497;956.6030097509595;971.4754032822339;991.3853410885297;1032.3599368391644;10527.20817043007;10724.946375268073;10804.297720648132;10805.513751881184;10883.67348979532;591384;600977;604067;606444;613780;111967.88032119737;112643.87356126333;116664.8333516654;119853;120883.39558302329;925.9629614815467;982.6315131825565;1000.9449480278655;1003.1272792670278;1008.5763979128784;17480.65038699244;17513.21190546403;17648.73526897123;17936.910315448862;18026.90986545059;49586;50754.95470271796;50764.238536421246;51423.48576514187;51895;70663.64668176626;71095;71183.28816711767;71870;73186;7857.882131768142;8092.433529652868;8096.230858068474;8121.187881211831;8478.915210847812;9655.710328690151;10913.581234439473;12467.93766031164;12506.062045346818;13076.280804555841;9333.486658233862;9720.979297173695;11101.888981110085;11691.707707307385;11709.473073711873;11277.830832537682;11318.490667920129;11416.486258118239;11545.942270288595;11623.709407264885;11641.301521908712;11754.05967522579;11824.940875295568;11852.703682407664;11987.34069626179;7779.922200778146;8070.394720395876;8177.386695997943;8300.792480188044;8415.705450309455;10993.835092473459;11631.243969141979;11659.475323610288;11692.590759323382;11754.353510557 03:29:16 INFO - PROCESS | 1683 | |3;mootools.html;1413.4982081361118;1565.7964464619602;1773.6009397885477;1913.6268427656603;1922.9519262018457;7855.253750893656;8485;8603;8744.606492707835;8830.86753698695;8596.8710469343;8601.784955376119;8657.307415406769;8695.34784891134;8700.956495217531;2375.6911601491825;2400.9159679411223;2406.2660888429023;2410.842795458181;2411.0958390603523;2440.6583078369044;2470.950580988379;2482.2429159106464;2487.253823852837;2488.054539275073;2456.9262922112366;2463.9137630182945;2472.5673007223754;2479.5536803375385;2488.776010159085;2430.8257027151103;2444.0712529238863;2456.4841383309526;2470.2218801077784;2473.6165894286323;2160.5894879972757;2196.0666716645524;2196.7144271244797;2197.6593627987686;2202.218212534543;8775.561221938877;8788.252998495072;8797.736067917973;8848.513331766815;8862.778430539223;4623.42207224097;5411.675299482044;5478.397376288645;5495.313085864267;5501.779928802843;2969.420962912233;3553.6091029986683;3557.3596752584526;3614.1868079682126;3630.6550877666577;1055.113704488226;1068.086785798139;1069.2461814420815;1070.0423121306387;1070.4433694478828;11353.489092990836;11687.532498700042;11712.765744685144;11813.350265735382;11865.991390731799;4821.662483626183;4902.14212512816;4964.801407943714;4970.925436118461;4980.003999200102;10135.797284054424;10159.644412445528;10167.983201679774;10177;10187;5465.754041068161;5489.094299440628;5524.806631767869;5540.445955404508;5543.556515478752;4408.713433626804;4841.201201801663;4978.90042199154;4982.800687972441;5015.573676237488;3557.8043207623828;3836.654701076861;3886.892235712865;3920.0199950012498;3972.880813575597;1303.2376060004813;1310.5282098444552;1315.3952178342406;1316.9012324075732;1319.3271431569776;1344.267374281019;1361.1288775183891;1366.5558693424678;1381.7374698807193;1383.619504636213;7038.472114591426;7984.960075199587;8148.307393871469;8178.5092894426525;8202.38482113832;512.6437126197258;521.3473289671674;523.8480840556272;525.5060243371219;529.608090013395;5951.256092988377;6137.754489820357;6139.723712432951;6141.293751218578;6262.467690246289;10461.476926153662;10696.465176741132;10767.515461804238;10790.838137427945;10832.72918177036;9033;10569.471526423647;10650.94674526638;10661.84007239892;10682.092022178202;7074.646267686698;7783.143854176149;7891.644875980594;8294.419390642717;8323.001239851257;6861.245263020964;7449.925500744923;7934.880976785237;7992.800179995546;8017;9283.48940808262;9384.343095983215;9499.620015199314;9605.13553780163;9608.615655373986;9035.412698174598;9035.45787252767;9294.907050929403;9955.800883982425;10097.848532272168;5791;7470.215627359049;7556.697732090654;7843.294103530481;8113.269805717514;8250.257476827115;8271.2142346477;8297.875531867148;8322.916770832215;8346.081930987708;7284.307990740871;7363.852722945404;7381.704731810667;7559;7565.621718913922;7182.640867956686;7204.9279507204255;7272.781816545512;7315.341619254293;7368.115826100902;7786.4160187985;7798.610069496389;7821.843563128819;7825.100113487022;7828.960855195687;7012.649367531501;7045.295470452914;7052.894206586802;7116.644167791486;7125.67934442941;6157.599756015845;7135.179454362815;7164.355208031302;7165.3909417698;7175.067241258603 03:29:16 INFO - PROCESS | 1683 | |4;prototype.html;319.6962885259004;324.3966222825544;327.5528903047341;332.1546663740779;333.2235890375424;6793.728250869965;6814;6835.282295358984;6870.965645171767;6917.273686262945;5369.543588794957;6666.899996500057;6791.185057793072;6792;6823.112995310603;4744.098621261966;4830.251311046776;4915.451632735677;4962.528559786814;4968.850934471971;4927.728974906378;4936.728479933602;4941.604671626261;4963.776630051656;4965.031818795336;4875.756212189394;4890.608751299906;4908.7300198489065;4916.803327866881;4918.704877707331;4912.164931961575;4926.9014619707405;4927.088488629579;4927.531884470969;4934.80260789568;4214.831406743727;4217.135487225142;4218.050938538804;4221.978890105561;4224.683148763855;6290.748370065192;6536.93463065368;6538.280789113193;6565.54041217115;6608.702608382634;5731.541476681856;5775.566832487538;5782.190493330937;5815.592908496407;5918.336748463209;7337.963310183468;7340;7356.448266379989;7364.410847132217;7374.741884034033;4615.192341340286;4616.907661846744;4616.976915115437;4625.421822272216;4640;7380.1512826025155;7676.654550545239;7750.186230445778;7765.922340776577;7821.608919554;3912.8434862605745;4569.954300456953;4590.701604395704;4678.672492925462;4694.882627934329;4738.715677059387;4744.7390393528685;4748.786304616231;4748.810047598057;4768.785404656799;5199.324087868553;5221.190715439113;5702.2301989231755;5723.971380143073;5726.885462290731;7330.6701198445135;7332.743353982585;7346.008288881039;7356.190819009905;7366.305749677605;1644.6957312896914;1658.9917050414913;1668.032541126144;1668.3993762245582;1669.7829282193238;859.2610355094614;890.950997695133;963.7349728824629;1017.4658304390107;1070.2347821307803;5506;6748.696308666122;6767.154105736783;6816.488763342769;6851.520393572402;7460.365868901095;7507.324340809353;7531.171571127172;7534.623268836536;7554.735584254525;5884.617499862496;6789.083473730983;6794.66026698673;6811.659417029129;6814.965925170342;3192.4413227685063;3921.627445392683;3934.3114954883354;3978.8209530571194;3995.9400608990886;7982.363615458817;7983.481073730305;7999.520028798291;8050.27547520726;8053.234942680436;7927.445078844426;7932.325752311118;7938.166492518202;7942.324902383247;7960.761177164694;6569.948808190667;7885.053793544582;7977.880331795028;8041.155678653658;8061;7272.527285726411;7587.2412758723685;7609.239076092346;7670.117936437381;7711.537307761552;7333.266673332838;7381.630918454163;7402.407807375289;7415.555066696015;7419.1467981180695;7859.84280314402;7889.3294070004695;7906.565138917184;7910.485818421784;7926.564038977681;4645.047765208056;4688.906221875475;4701.764911754467;4718.8584342469785;4726.740029298284;7265.803046659453;7439.70241190368;7572.734954276574;7581;7615.5430674157515;6851;7266.89099663516;7334.4132469403385;7356.301151390609;7368.778936631909;7280.344768970818;7331.4134869209265;7336.4130869529245;7338.77983660491;7345.375643070399;6160.691965401802;6839.281875403011;6929.89605155913;7116.964415177891;7172.0676312079095;7313.122425308997;7344.485885988143;7361.889571656322;7376.7049318026675;7395.852082958203;7149.964250178716;7174;7193.568385896863;7193.892091618734;7196.856062878818 03:29:16 INFO - PROCESS | 1683 | |5;yui.html;581.3808294166715;622.3962756126557;666.5534092158257;669.9430548403385;727.1456039153996;12745.171563848344;14502.274886255684;15162.924185379085;15264.389424423038;15338.46315378962;13757.449702011907;13875.236861972588;14359.712805743879;14406.711865762678;14411.78382324266;702.768086531446;724.7427163357024;836.9121242269565;868.1839071273015;868.9695860644879;849.7408290471403;869.5261082709907;875.0855356152836;875.7329014650529;879.9384043116985;909.8544232922734;920.2913756407596;921.3780698028837;921.7695576105973;923.5336155241594;891.4517571693427;900.1898291537635;903.7876099116702;906.7189171356835;908.3641450984337;645.5868244323636;671.8622682350156;675.5170053411784;679.2392520377209;679.6873438218425;14817.407303707838;14932.25338733059;14983.550493485212;15097.169655668933;15148.394064237416;12810.935945320307;12820.423080961378;12975.091743577954;13034.934825325907;13168.209907405586;9798.216142708638;10036.64871729486;10062.64780732678;10147.137493313003;10445.52995115214;3458.3083383323437;3521.1197200699826;3525.7708248963736;3574.910627234314;3687.50218720472;75216.62391688007;76486;77201.61399192968;77263.22736772617;78039;9439.952800235955;9466.715998520056;9475.573599188054;9568.712938611852;10029.922202274029;21501.354959351243;21531.13875444996;21614.919254037548;21629.675554866688;21640.56718865614;7361.8159546011775;7453.440991925628;7493.775186744407;7565.167831538526;7615.5430674158615;4113.794310284474;4127.669786417079;4147.149834283965;4154.646855017297;4168.8332466700995;3478.617352091268;3483.2336885885065;3499.107727529464;3516.1736991806906;3545.1314427965312;585.9414058594192;606.1695477196181;612.8437248501692;633.0883527720068;636.2269842141727;482.4066398330004;578.0664227273008;588.7527238559816;596.1713218626113;602.2441835496423;8151.79620509492;8249.628766705513;8327.167283271625;8434.873476897852;8458.746237612759;443.7182389182892;499.3533374280316;525.4850246758122;529.891372268684;600.4145957691217;3046.1470788179345;3901.1027463682944;3935.3506671399473;3995.260876737813;4020.9396859047138;85236.57381713176;97867;99286;100829.49585252027;102308;50901.21845735382;69236.6538167316;72486.275137249;72930.27069729235;72949;51474.99999999925;58879;61734.69132654398;65365;65477.05353259115;8309.626066827128;8390.496570205807;8440.987081550007;8524.573771311534;8639.654413823628;46233.61299161031;47294;47929.76035119802;49248.38227974116;49319;61332.69333653303;63328;64246.71506569749;64435;66404.66797665981;10527.736806579896;10822.621208257988;10834.349939003685;11122.221444499131;11173.050290725054;11591.76816463683;12302.323372214614;12384.56654017105;12405.131640785059;12618.17981831178;9864.605415783288;11371.260868043551;11725.530978761095;11758.529658813552;11766.352850592957;11254.099672026383;11641.767164656829;11645;11650.184487085822;12312.876871231172;11082.722931926766;11129.610463633733;11152.219344645797;11400.885991140314;11519.481623327138;8298.879651247003;9135.132162444557;9501.049895010443;9761.267904907018;10014.198864091;9081.863772043293;9204.263658907405;9253.398529095588;9722.270829687943;9747.25656686049 03:29:16 INFO - PROCESS | 1683 | __end_tp_report 03:29:16 INFO - PROCESS | 1683 | __start_cc_report 03:29:16 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,337 03:29:16 INFO - PROCESS | 1683 | __end_cc_report 03:29:16 INFO - PROCESS | 1683 | __startTimestamp1456486156684__endTimestamp 03:29:16 INFO - PROCESS | 1683 | 03:29:16 INFO - PROCESS | 1683 | ------- Summary: start ------- 03:29:16 INFO - PROCESS | 1683 | Number of tests: 6 03:29:16 INFO - PROCESS | 1683 | 03:29:16 INFO - PROCESS | 1683 | [#0] dojo.html Cycles:165 Average:5712.51 Median:5838.39 stddev:615.43 (10.5%) stddev-sans-first:592.12 03:29:16 INFO - PROCESS | 1683 | Values: 3490.3 3532.0 3555.6 3587.2 3593.6 5692.8 5716.9 5732.9 5733.8 5818.5 5679.0 5706.5 5804.7 5811.9 5943.4 5154.4 5195.0 5217.3 5251.1 5272.4 5204.4 5216.9 5273.4 5275.8 5280.1 5105.4 5131.3 5210.9 5212.1 5219.7 5178.3 5194.1 5194.2 5205.9 5247.2 5018.0 5138.9 5159.3 5161.6 5191.3 5377.8 5469.2 5626.9 5669.9 5688.9 6230.7 6255.9 6259.3 6259.9 6299.3 6126.5 6174.7 6196.4 6225.1 6246.4 5803.2 5805.1 5808.8 5815.7 5829.6 4965.6 5271.2 6178.9 6251.6 6289.9 5041.7 6042.8 6113.3 6114.8 6124.7 6079.3 6132.2 6173.3 6217.3 6226.4 5290.7 6201.7 6236.4 6244.6 6244.7 5736.0 5828.8 6144.9 6262.2 6279.2 4838.4 4869.6 4888.1 4909.7 4933.0 4398.2 4402.3 4405.0 4408.4 4461.8 5659.8 5672.5 5688.7 5692.9 5793.2 6221.7 6223.8 6233.0 6250.1 6275.9 5692.0 5757.1 5772.3 5790.3 5805.8 5340.3 5376.9 5381.1 5390.5 5423.7 6236.7 6238.5 6258.1 6273.7 6282.8 6127.0 6154.8 6211.4 6225.7 6251.7 6198.9 6270.2 6275.8 6277.4 6284.1 6123.5 6174.2 6195.4 6214.8 6228.2 6137.2 6161.2 6174.7 6260.9 6261.5 5838.4 6082.2 6089.8 6112.7 6159.6 5907.4 6071.9 6091.5 6110.6 6129.6 5770.0 5805.6 5908.2 5952.0 5956.5 6120.1 6134.5 6137.0 6138.0 6174.8 6039.0 6040.7 6045.0 6048.8 6075.2 03:29:16 INFO - PROCESS | 1683 | 03:29:16 INFO - PROCESS | 1683 | [#1] ext.html Cycles:180 Average:61031.81 Median:37500.44 stddev:123871.48 (330.3%) stddev-sans-first:124135.48 03:29:16 INFO - PROCESS | 1683 | Values: 454.6 466.6 525.9 553.5 561.7 32666.0 37233.9 37256.6 37327.1 37538.4 32371.4 37850.2 38472.0 38564.8 38596.4 8306.1 9260.6 9400.8 9402.7 9408.6 9407.5 9630.3 9635.3 9659.9 9703.9 9559.2 9587.7 9595.6 9626.3 9671.4 8457.0 9568.4 9586.8 9650.8 9652.6 8372.0 8870.8 9213.2 9493.5 9607.0 38275.4 38461.0 38529.0 38552.6 38575.8 3189.9 3204.1 3213.8 3350.5 3385.4 26434.1 28108.4 28199.0 28419.0 28566.4 2543.6 2768.4 2784.2 2865.1 2877.7 359473.0 359514.0 361160.0 361195.0 480668.0 62643.4 62834.4 62931.7 63005.7 63028.0 60454.7 65203.0 70384.3 71260.0 71380.0 13673.9 16064.6 16074.9 16201.9 16273.3 12319.8 12321.8 12374.4 12417.8 12486.1 20301.7 20487.4 20590.2 20642.7 20670.2 8845.3 9044.7 9057.8 9065.4 9102.3 894.6 922.9 1027.3 1053.5 1086.8 28988.4 29037.7 29058.5 29579.3 29645.9 942.7 1111.3 1127.3 1179.6 1188.1 14731.6 14983.3 14993.4 14998.0 15076.9 529897.0 530573.0 533415.0 534307.0 536289.0 56544.7 56740.0 56745.4 56898.6 56996.6 1340.4 1341.7 1344.8 1387.4 1388.8 27827.2 27874.0 28667.0 28986.0 29302.9 49390.0 49404.5 49748.5 49809.0 49836.0 462605.0 463743.0 467073.0 469366.0 469871.0 32511.7 41656.0 43180.8 43342.1 43483.0 45036.5 45797.8 46142.8 46154.8 46403.0 35075.3 35317.0 35597.6 35990.5 36063.3 34846.0 35826.8 35979.3 36348.8 36666.1 31980.0 36998.4 37282.3 37462.4 38443.0 30796.2 31464.7 31489.7 31538.5 31674.4 18667.4 23340.5 24014.6 24151.9 24441.9 03:29:16 INFO - PROCESS | 1683 | 03:29:16 INFO - PROCESS | 1683 | [#2] jquery.html Cycles:180 Average:34166.98 Median:24374.38 stddev:100189.43 (411.0%) stddev-sans-first:100438.30 03:29:16 INFO - PROCESS | 1683 | Values: 346.2 353.3 357.5 357.9 359.8 18539.1 18804.3 19196.0 19486.3 19513.2 14426.9 17702.7 19397.8 20537.2 20689.3 5597.0 5876.1 5927.1 5935.5 5944.3 4169.4 5742.8 6209.7 6516.0 6522.6 6003.2 6065.9 6430.9 6441.0 6497.9 6153.4 6402.2 6404.5 6427.3 6430.4 5318.7 5522.9 5528.5 5539.9 5548.8 12536.0 13173.2 24323.9 24424.9 24462.4 1997.7 2020.6 2123.6 2232.2 2497.6 9853.0 9942.5 10554.6 12044.0 14567.3 1652.7 1666.1 1722.6 1738.1 1753.7 107653.0 111796.4 112180.0 113328.0 113477.3 11338.7 11523.9 11583.7 11611.8 11668.9 13805.5 13859.2 13866.8 13873.2 13900.0 8260.2 8420.5 8430.1 8508.1 8509.4 7778.3 8466.7 8530.2 8595.3 8604.5 4359.0 4470.8 4480.3 4496.6 4498.0 1737.9 1812.8 1855.3 1870.6 1893.9 883.9 956.9 957.6 962.1 994.4 18947.3 19909.0 19910.7 19953.6 20220.0 951.8 956.6 971.5 991.4 1032.4 10527.2 10724.9 10804.3 10805.5 10883.7 591384.0 600977.0 604067.0 606444.0 613780.0 111967.9 112643.9 116664.8 119853.0 120883.4 926.0 982.6 1000.9 1003.1 1008.6 17480.7 17513.2 17648.7 17936.9 18026.9 49586.0 50755.0 50764.2 51423.5 51895.0 70663.6 71095.0 71183.3 71870.0 73186.0 7857.9 8092.4 8096.2 8121.2 8478.9 9655.7 10913.6 12467.9 12506.1 13076.3 9333.5 9721.0 11101.9 11691.7 11709.5 11277.8 11318.5 11416.5 11545.9 11623.7 11641.3 11754.1 11824.9 11852.7 11987.3 7779.9 8070.4 8177.4 8300.8 8415.7 10993.8 11631.2 11659.5 11692.6 11754.4 03:29:16 INFO - PROCESS | 1683 | 03:29:16 INFO - PROCESS | 1683 | [#3] mootools.html Cycles:180 Average:5984.30 Median:2970.64 stddev:3170.57 (106.7%) stddev-sans-first:3160.84 03:29:16 INFO - PROCESS | 1683 | Values: 1413.5 1565.8 1773.6 1913.6 1923.0 7855.3 8485.0 8603.0 8744.6 8830.9 8596.9 8601.8 8657.3 8695.3 8701.0 2375.7 2400.9 2406.3 2410.8 2411.1 2440.7 2471.0 2482.2 2487.3 2488.1 2456.9 2463.9 2472.6 2479.6 2488.8 2430.8 2444.1 2456.5 2470.2 2473.6 2160.6 2196.1 2196.7 2197.7 2202.2 8775.6 8788.3 8797.7 8848.5 8862.8 4623.4 5411.7 5478.4 5495.3 5501.8 2969.4 3553.6 3557.4 3614.2 3630.7 1055.1 1068.1 1069.2 1070.0 1070.4 11353.5 11687.5 11712.8 11813.4 11866.0 4821.7 4902.1 4964.8 4970.9 4980.0 10135.8 10159.6 10168.0 10177.0 10187.0 5465.8 5489.1 5524.8 5540.4 5543.6 4408.7 4841.2 4978.9 4982.8 5015.6 3557.8 3836.7 3886.9 3920.0 3972.9 1303.2 1310.5 1315.4 1316.9 1319.3 1344.3 1361.1 1366.6 1381.7 1383.6 7038.5 7985.0 8148.3 8178.5 8202.4 512.6 521.3 523.8 525.5 529.6 5951.3 6137.8 6139.7 6141.3 6262.5 10461.5 10696.5 10767.5 10790.8 10832.7 9033.0 10569.5 10650.9 10661.8 10682.1 7074.6 7783.1 7891.6 8294.4 8323.0 6861.2 7449.9 7934.9 7992.8 8017.0 9283.5 9384.3 9499.6 9605.1 9608.6 9035.4 9035.5 9294.9 9955.8 10097.8 5791.0 7470.2 7556.7 7843.3 8113.3 8250.3 8271.2 8297.9 8322.9 8346.1 7284.3 7363.9 7381.7 7559.0 7565.6 7182.6 7204.9 7272.8 7315.3 7368.1 7786.4 7798.6 7821.8 7825.1 7829.0 7012.6 7045.3 7052.9 7116.6 7125.7 6157.6 7135.2 7164.4 7165.4 7175.1 03:29:16 INFO - PROCESS | 1683 | 03:29:16 INFO - PROCESS | 1683 | [#4] prototype.html Cycles:180 Average:5926.91 Median:6812.83 stddev:1956.57 (28.7%) stddev-sans-first:1916.26 03:29:16 INFO - PROCESS | 1683 | Values: 319.7 324.4 327.6 332.2 333.2 6793.7 6814.0 6835.3 6871.0 6917.3 5369.5 6666.9 6791.2 6792.0 6823.1 4744.1 4830.3 4915.5 4962.5 4968.9 4927.7 4936.7 4941.6 4963.8 4965.0 4875.8 4890.6 4908.7 4916.8 4918.7 4912.2 4926.9 4927.1 4927.5 4934.8 4214.8 4217.1 4218.1 4222.0 4224.7 6290.7 6536.9 6538.3 6565.5 6608.7 5731.5 5775.6 5782.2 5815.6 5918.3 7338.0 7340.0 7356.4 7364.4 7374.7 4615.2 4616.9 4617.0 4625.4 4640.0 7380.2 7676.7 7750.2 7765.9 7821.6 3912.8 4570.0 4590.7 4678.7 4694.9 4738.7 4744.7 4748.8 4748.8 4768.8 5199.3 5221.2 5702.2 5724.0 5726.9 7330.7 7332.7 7346.0 7356.2 7366.3 1644.7 1659.0 1668.0 1668.4 1669.8 859.3 891.0 963.7 1017.5 1070.2 5506.0 6748.7 6767.2 6816.5 6851.5 7460.4 7507.3 7531.2 7534.6 7554.7 5884.6 6789.1 6794.7 6811.7 6815.0 3192.4 3921.6 3934.3 3978.8 3995.9 7982.4 7983.5 7999.5 8050.3 8053.2 7927.4 7932.3 7938.2 7942.3 7960.8 6569.9 7885.1 7977.9 8041.2 8061.0 7272.5 7587.2 7609.2 7670.1 7711.5 7333.3 7381.6 7402.4 7415.6 7419.1 7859.8 7889.3 7906.6 7910.5 7926.6 4645.0 4688.9 4701.8 4718.9 4726.7 7265.8 7439.7 7572.7 7581.0 7615.5 6851.0 7266.9 7334.4 7356.3 7368.8 7280.3 7331.4 7336.4 7338.8 7345.4 6160.7 6839.3 6929.9 7117.0 7172.1 7313.1 7344.5 7361.9 7376.7 7395.9 7150.0 7174.0 7193.6 7193.9 7196.9 03:29:16 INFO - PROCESS | 1683 | 03:29:16 INFO - PROCESS | 1683 | [#5] yui.html Cycles:180 Average:17614.64 Median:583.66 stddev:24516.25 (4200.4%) stddev-sans-first:24551.67 03:29:16 INFO - PROCESS | 1683 | Values: 581.4 622.4 666.6 669.9 727.1 12745.2 14502.3 15162.9 15264.4 15338.5 13757.4 13875.2 14359.7 14406.7 14411.8 702.8 724.7 836.9 868.2 869.0 849.7 869.5 875.1 875.7 879.9 909.9 920.3 921.4 921.8 923.5 891.5 900.2 903.8 906.7 908.4 645.6 671.9 675.5 679.2 679.7 14817.4 14932.3 14983.6 15097.2 15148.4 12810.9 12820.4 12975.1 13034.9 13168.2 9798.2 10036.6 10062.6 10147.1 10445.5 3458.3 3521.1 3525.8 3574.9 3687.5 75216.6 76486.0 77201.6 77263.2 78039.0 9440.0 9466.7 9475.6 9568.7 10029.9 21501.4 21531.1 21614.9 21629.7 21640.6 7361.8 7453.4 7493.8 7565.2 7615.5 4113.8 4127.7 4147.1 4154.6 4168.8 3478.6 3483.2 3499.1 3516.2 3545.1 585.9 606.2 612.8 633.1 636.2 482.4 578.1 588.8 596.2 602.2 8151.8 8249.6 8327.2 8434.9 8458.7 443.7 499.4 525.5 529.9 600.4 3046.1 3901.1 3935.4 3995.3 4020.9 85236.6 97867.0 99286.0 100829.5 102308.0 50901.2 69236.7 72486.3 72930.3 72949.0 51475.0 58879.0 61734.7 65365.0 65477.1 8309.6 8390.5 8441.0 8524.6 8639.7 46233.6 47294.0 47929.8 49248.4 49319.0 61332.7 63328.0 64246.7 64435.0 66404.7 10527.7 10822.6 10834.3 11122.2 11173.1 11591.8 12302.3 12384.6 12405.1 12618.2 9864.6 11371.3 11725.5 11758.5 11766.4 11254.1 11641.8 11645.0 11650.2 12312.9 11082.7 11129.6 11152.2 11400.9 11519.5 8298.9 9135.1 9501.0 9761.3 10014.2 9081.9 9204.3 9253.4 9722.3 9747.3 03:29:16 INFO - PROCESS | 1683 | -------- Summary: end -------- 03:29:16 INFO - PROCESS | 1683 | 03:29:17 INFO - TEST-INFO | 1683: exit 0 03:29:17 INFO - TEST-OK | dromaeo_css | took 1110872ms 03:29:17 INFO - TEST-START | kraken 03:29:17 INFO - operating with platform_type : mac_ 03:29:17 INFO - Initialising browser for kraken test... 03:29:17 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpxuMjzm/profile http://localhost:49276/getInfo.html) 03:29:19 INFO - PROCESS | 1690 | __metrics Screen width/height:1600/1200 03:29:19 INFO - PROCESS | 1690 | colorDepth:24 03:29:19 INFO - PROCESS | 1690 | Browser inner width/height: 1024/689 03:29:19 INFO - PROCESS | 1690 | __metrics 03:29:19 ERROR - PROCESS | 1690 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:29:20 INFO - TEST-INFO | 1690: exit 0 03:29:20 INFO - Browser initialized. 03:29:20 INFO - Running cycle 1/1 for kraken test... 03:29:20 INFO - TEST-INFO | started process 1693 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpxuMjzm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:32 INFO - PROCESS | 1693 | RSS: Main: 256385024 03:29:32 INFO - PROCESS | 1693 | 03:29:35 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 03:29:36 INFO - PROCESS | 1693 | RSS: Main: 267739136 03:29:36 INFO - PROCESS | 1693 | 03:29:38 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 03:29:39 INFO - PROCESS | 1693 | RSS: Main: 276631552 03:29:39 INFO - PROCESS | 1693 | 03:29:42 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 03:29:43 INFO - PROCESS | 1693 | RSS: Main: 279371776 03:29:43 INFO - PROCESS | 1693 | 03:29:45 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 03:29:45 INFO - PROCESS | 1693 | RSS: Main: 280203264 03:29:45 INFO - PROCESS | 1693 | 03:29:47 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:29:48 INFO - PROCESS | 1693 | RSS: Main: 280682496 03:29:48 INFO - PROCESS | 1693 | 03:29:51 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 03:29:51 INFO - PROCESS | 1693 | RSS: Main: 283582464 03:29:51 INFO - PROCESS | 1693 | 03:29:54 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 03:29:55 INFO - PROCESS | 1693 | RSS: Main: 283693056 03:29:55 INFO - PROCESS | 1693 | 03:29:58 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 03:29:59 INFO - PROCESS | 1693 | RSS: Main: 284364800 03:29:59 INFO - PROCESS | 1693 | 03:30:00 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:30:01 INFO - PROCESS | 1693 | RSS: Main: 282710016 03:30:01 INFO - PROCESS | 1693 | 03:30:03 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:30:03 INFO - PROCESS | 1693 | RSS: Main: 282226688 03:30:03 INFO - PROCESS | 1693 | 03:30:06 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:30:06 INFO - PROCESS | 1693 | RSS: Main: 283435008 03:30:06 INFO - PROCESS | 1693 | 03:30:09 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:30:10 INFO - PROCESS | 1693 | RSS: Main: 282546176 03:30:10 INFO - PROCESS | 1693 | 03:30:12 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:30:13 INFO - PROCESS | 1693 | RSS: Main: 283414528 03:30:13 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 03:30:15 INFO - PROCESS | 1693 | RSS: Main: 284221440 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | __start_tp_report 03:30:15 INFO - PROCESS | 1693 | _x_x_mozilla_page_load 03:30:15 INFO - PROCESS | 1693 | _x_x_mozilla_page_load_details 03:30:15 INFO - PROCESS | 1693 | |i|pagename|runs| 03:30:15 INFO - PROCESS | 1693 | |0;ai-astar;115;109;115;115;117;162;170;151;116;118 03:30:15 INFO - PROCESS | 1693 | |1;audio-beat-detection;174;154;146;155;123;142;142;121;156;123 03:30:15 INFO - PROCESS | 1693 | |2;audio-dft;192;196;205;229;204;203;198;197;205;193 03:30:15 INFO - PROCESS | 1693 | |3;audio-fft;75;80;71;111;80;82;82;78;112;59 03:30:15 INFO - PROCESS | 1693 | |4;audio-oscillator;83;88;117;81;81;82;117;76;81;119 03:30:15 INFO - PROCESS | 1693 | |5;imaging-gaussian-blur;88;94;89;95;89;135;86;95;87;95 03:30:15 INFO - PROCESS | 1693 | |6;imaging-darkroom;97;97;97;97;122;103;152;150;101;140 03:30:15 INFO - PROCESS | 1693 | |7;imaging-desaturate;126;78;146;147;109;77;125;77;80;116 03:30:15 INFO - PROCESS | 1693 | |8;json-parse-financial;57;61;60;58;58;57;58;63;57;55 03:30:15 INFO - PROCESS | 1693 | |9;json-stringify-tinderbox;67;76;63;73;98;69;59;67;91;101 03:30:15 INFO - PROCESS | 1693 | |10;stanford-crypto-aes;95;110;89;108;113;72;96;110;110;76 03:30:15 INFO - PROCESS | 1693 | |11;stanford-crypto-ccm;136;117;118;151;134;136;128;129;121;133 03:30:15 INFO - PROCESS | 1693 | |12;stanford-crypto-pbkdf2;136;171;176;142;142;137;163;171;132;173 03:30:15 INFO - PROCESS | 1693 | |13;stanford-crypto-sha256-iterative;67;74;95;65;85;93;94;68;82;90 03:30:15 INFO - PROCESS | 1693 | __end_tp_report 03:30:15 INFO - PROCESS | 1693 | __start_cc_report 03:30:15 INFO - PROCESS | 1693 | _x_x_mozilla_cycle_collect,877 03:30:15 INFO - PROCESS | 1693 | __end_cc_report 03:30:15 INFO - PROCESS | 1693 | __startTimestamp1456486215393__endTimestamp 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | ------- Summary: start ------- 03:30:15 INFO - PROCESS | 1693 | Number of tests: 14 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | [#0] ai-astar Cycles:10 Average:128.80 Median:117.50 stddev:22.79 (19.4%) stddev-sans-first:23.62 03:30:15 INFO - PROCESS | 1693 | Values: 115.0 109.0 115.0 115.0 117.0 162.0 170.0 151.0 116.0 118.0 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:150.00 stddev:17.28 (11.5%) stddev-sans-first:14.40 03:30:15 INFO - PROCESS | 1693 | Values: 174.0 154.0 146.0 155.0 123.0 142.0 142.0 121.0 156.0 123.0 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | [#2] audio-dft Cycles:10 Average:202.20 Median:203.50 stddev:10.59 (5.2%) stddev-sans-first:10.57 03:30:15 INFO - PROCESS | 1693 | Values: 192.0 196.0 205.0 229.0 204.0 203.0 198.0 197.0 205.0 193.0 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | [#3] audio-fft Cycles:10 Average:83.00 Median:79.00 stddev:16.51 (20.9%) stddev-sans-first:17.26 03:30:15 INFO - PROCESS | 1693 | Values: 75.0 80.0 71.0 111.0 80.0 82.0 82.0 78.0 112.0 59.0 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:81.00 stddev:17.61 (21.7%) stddev-sans-first:18.34 03:30:15 INFO - PROCESS | 1693 | Values: 83.0 88.0 117.0 81.0 81.0 82.0 117.0 76.0 81.0 119.0 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | [#5] imaging-gaussian-blur Cycles:10 Average:95.30 Median:91.50 stddev:14.40 (15.7%) stddev-sans-first:15.03 03:30:15 INFO - PROCESS | 1693 | Values: 88.0 94.0 89.0 95.0 89.0 135.0 86.0 95.0 87.0 95.0 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | [#6] imaging-darkroom Cycles:10 Average:115.60 Median:124.50 stddev:23.33 (18.7%) stddev-sans-first:23.76 03:30:15 INFO - PROCESS | 1693 | Values: 97.0 97.0 97.0 97.0 122.0 103.0 152.0 150.0 101.0 140.0 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | [#7] imaging-desaturate Cycles:10 Average:108.10 Median:112.00 stddev:28.38 (25.3%) stddev-sans-first:29.35 03:30:15 INFO - PROCESS | 1693 | Values: 126.0 78.0 146.0 147.0 109.0 77.0 125.0 77.0 80.0 116.0 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.00 stddev:2.32 (4.0%) stddev-sans-first:2.40 03:30:15 INFO - PROCESS | 1693 | Values: 57.0 61.0 60.0 58.0 58.0 57.0 58.0 63.0 57.0 55.0 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | [#9] json-stringify-tinderbox Cycles:10 Average:76.40 Median:71.00 stddev:14.95 (21.1%) stddev-sans-first:15.46 03:30:15 INFO - PROCESS | 1693 | Values: 67.0 76.0 63.0 73.0 98.0 69.0 59.0 67.0 91.0 101.0 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | [#10] stanford-crypto-aes Cycles:10 Average:97.90 Median:74.00 stddev:14.95 (20.2%) stddev-sans-first:15.82 03:30:15 INFO - PROCESS | 1693 | Values: 95.0 110.0 89.0 108.0 113.0 72.0 96.0 110.0 110.0 76.0 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:133.50 stddev:10.20 (7.6%) stddev-sans-first:10.61 03:30:15 INFO - PROCESS | 1693 | Values: 136.0 117.0 118.0 151.0 134.0 136.0 128.0 129.0 121.0 133.0 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:167.00 stddev:17.91 (10.7%) stddev-sans-first:17.73 03:30:15 INFO - PROCESS | 1693 | Values: 136.0 171.0 176.0 142.0 142.0 137.0 163.0 171.0 132.0 173.0 03:30:15 INFO - PROCESS | 1693 | 03:30:15 INFO - PROCESS | 1693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.30 Median:87.50 stddev:11.91 (13.6%) stddev-sans-first:11.45 03:30:15 INFO - PROCESS | 1693 | Values: 67.0 74.0 95.0 65.0 85.0 93.0 94.0 68.0 82.0 90.0 03:30:15 INFO - PROCESS | 1693 | -------- Summary: end -------- 03:30:15 INFO - PROCESS | 1693 | 03:30:16 INFO - TEST-INFO | 1693: exit 0 03:30:16 INFO - TEST-OK | kraken | took 58949ms 03:30:16 INFO - SUITE-END | took 1169s 03:30:16 INFO - Completed test suite (00:19:30) 03:30:16 INFO - Working with test: dromaeo_css 03:30:16 INFO - Generating results file: dromaeo_css 03:30:16 INFO - Working with test: kraken 03:30:16 INFO - Generating results file: kraken 03:30:16 INFO - javascript benchmark 03:30:16 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:30:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 03:30:16 INFO - process_Request line: dromaeo_css 7484.66 graph.html#tests=[[72,64,61]] 03:30:16 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:30:16 INFO - process_Request line: kraken 1567.70 graph.html#tests=[[232,64,61]] 03:30:16 INFO - RETURN: dromaeo_css: 7484.66 03:30:16 INFO - RETURN: kraken: 1567.70 03:30:16 INFO - javascript benchmark 03:30:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3490.3019396120776, 3531.999999999998, 3555.5733312002562, 3587.1928816016393, 3593.5508061492314, 5692.800751973682, 5716.914246286309, 5732.885342293152, 5733.827985160441, 5818.476337129658, 5678.971605141968, 5706.486416222539, 5804.738786754596, 5811.941880581193, 5943.375945525722, 5154.381474223089, 5194.974025129888, 5217.295665085203, 5251.10731175701, 5272.393674727398, 5204.42751297357, 5216.947830521684, 5273.419923808378, 5275.841724748264, 5280.128778751501, 5105.3873535175835, 5131.332926719521, 5210.895782084375, 5212.139996900545, 5219.660722053054, 5178.275041494194, 5194.142966410538, 5194.246834209056, 5205.869853253661, 5247.2129180623215, 5018.046571151506, 5138.948610513884, 5159.329287192679, 5161.638685292031, 5191.299174611455, 5377.843763590808, 5469.206964990054, 5626.887462250732, 5669.8582535436535, 5688.914666280009, 6230.719617617173, 6255.9364907965755, 6259.311475737711, 6259.87480250397, 6299.275583307933, 6126.456603435073, 6174.691265436755, 6196.411340922605, 6225.097360882692, 6246.440098727954, 5803.245578074865, 5805.071188609802, 5808.82573522795, 5815.738291776795, 5829.621074630136, 4965.553100220997, 5271.156614941591, 6178.938210617926, 6251.562390632612, 6289.905651415233, 5041.6722913010535, 6042.818715438544, 6113.32753397126, 6114.844865410725, 6124.724387402578, 6079.331273559905, 6132.202813634199, 6173.259208894961, 6217.316095229521, 6226.439620434183, 5290.65610735301, 6201.6899155042065, 6236.438720515175, 6244.594101383486, 6244.718987645567, 5735.996200664867, 5828.766849326064, 6144.8771024580155, 6262.185915830913, 6279.152314437492, 4838.395200599925, 4869.63477739171, 4888.095702295087, 4909.70541767488, 4932.975335123373, 4398.164348773723, 4402.273624851928, 4405.008873003549, 4408.448943882015, 4461.7992190351515, 5659.801906933238, 5672.461116193955, 5688.744006519716, 5692.8861422771315, 5793.188953546507, 6221.657808820468, 6223.844403889939, 6233.0, 6250.124982502453, 6275.937240627535, 5691.9715401423555, 5757.136429535603, 5772.278465191851, 5790.276215473066, 5805.796797112081, 5340.332458442695, 5376.865578360573, 5381.0583147948955, 5390.51485366319, 5423.674579525241, 6236.719347629368, 6238.500919926395, 6258.061290806416, 6273.65494897785, 6282.842928926813, 6127.0062805303205, 6154.753809847556, 6211.378862113753, 6225.719842607185, 6251.749930002931, 6198.876022479615, 6270.216222972129, 6275.780347687809, 6277.403646653561, 6284.057391391328, 6123.479504242189, 6174.228221472316, 6195.4424101829245, 6214.782482613087, 6228.190335256388, 6137.202163718866, 6161.199044124235, 6174.6912654368, 6260.906086408617, 6261.530385221035, 5838.3869693683255, 6082.2093127893095, 6089.817305480843, 6112.663803490673, 6159.5688301818445, 5907.409259074058, 6071.878562428638, 6091.512678985582, 6110.572259941761, 6129.601575897553, 5769.9711501442225, 5805.622634528742, 5908.231929849092, 5952.0476723724, 5956.523478121827, 6120.08198770188, 6134.539909506716, 6136.969315153396, 6138.048602466625, 6174.783882564268, 6039.0, 6040.697965101639, 6045.002574575145, 6048.818535443944, 6075.2405949256345], "unit": "score", "name": "dojo.html", "value": 5676.476180366951}, {"lowerIsBetter": false, "replicates": [454.5636189258312, 466.553683580899, 525.8685328667833, 553.4907884746033, 561.7079118858196, 32666.0, 37233.882983510535, 37256.627433725655, 37327.06682332943, 37538.436923446134, 32371.352572948526, 37850.24299514008, 38472.03819904504, 38564.80717596415, 38596.421053684215, 8306.08633050364, 9260.583273752698, 9400.764980875465, 9402.670906518273, 9408.623655053789, 9407.52962351883, 9630.277729170306, 9635.277354198428, 9659.903400966006, 9703.854442183372, 9559.187469065138, 9587.712368628918, 9595.616175352978, 9626.326157169002, 9671.419714817099, 8457.0, 9568.37805542641, 9586.808263834719, 9650.806983860284, 9652.613895444174, 8372.0, 8870.778230544223, 9213.170814626716, 9493.525323733855, 9606.9519652402, 38275.425868611994, 38461.03847403809, 38529.0, 38552.61447385518, 38575.8071209645, 3189.9202519936957, 3204.102851201644, 3213.839308034589, 3350.5309256703836, 3385.4414021686393, 26434.074807381843, 28108.437831243464, 28199.0, 28419.0, 28566.428671426664, 2543.605741110131, 2768.3632764464287, 2784.1647505748397, 2865.126136528358, 2877.6690680571583, 359473.0, 359514.0, 361160.0, 361195.0, 480668.0, 62643.373566263755, 62834.37165628285, 62931.685341573, 63005.68497157576, 63028.0, 60454.69772651108, 65203.021954670716, 70384.29615703778, 71260.0, 71380.0, 13673.863261367458, 16064.598385040234, 16074.919625401799, 16201.918990404973, 16273.267702953395, 12319.75360492803, 12321.753564928831, 12374.443150058269, 12417.813732794015, 12486.063545234143, 20301.695474567892, 20487.38537843867, 20590.176392944115, 20642.690359644617, 20670.17319307241, 8845.292376609856, 9044.728658140266, 9057.81884362309, 9065.365424420359, 9102.31732620043, 894.561664784264, 922.935394522377, 1027.2655051638114, 1053.5311786255043, 1086.8369744538381, 28988.42023159525, 29037.709622903923, 29058.547072646285, 29579.26051848678, 29645.85177074144, 942.7218970403748, 1111.3109871879487, 1127.2841745491671, 1179.6402097360217, 1188.1267268557604, 14731.558053258204, 14983.32575034126, 14993.400263989319, 14998.025128366622, 15076.944613876924, 529897.0, 530573.0, 533415.0, 534307.0, 536289.0, 56544.71727641418, 56740.0, 56745.43254567401, 56898.57753556111, 56996.57508562319, 1340.3968214303602, 1341.6645838540364, 1344.7512210241136, 1387.4450219912117, 1388.7916812478209, 27827.16518504448, 27874.0, 28667.0, 28986.0, 29302.853485732434, 49390.0, 49404.50595494143, 49748.50251497439, 49809.0, 49836.0, 462605.0, 463743.0, 467073.0, 469366.0, 469871.0, 32511.67488325181, 41656.0, 43180.78409607932, 43342.133157336044, 43483.0, 45036.54963450324, 45797.77101114473, 46142.76928615336, 46154.76922615366, 46403.0, 35075.29849402946, 35317.0, 35597.64402356047, 35990.4601430984, 36063.27873442569, 34846.0, 35826.820865895505, 35979.28041439209, 36348.818255908554, 36666.083347916516, 31980.040598782074, 36998.44502332521, 37282.254354912206, 37462.43806342962, 38443.0, 30796.23009424782, 31464.685353146175, 31489.685103148677, 31538.526922096647, 31674.366512669156, 18667.439976800717, 23340.53318933578, 24014.63978040296, 24151.879240604387, 24441.87779061093], "unit": "score", "name": "ext.html", "value": 19421.223032839374}, {"lowerIsBetter": false, "replicates": [346.2192755336715, 353.2704964248826, 357.50307073168284, 357.94272916333387, 359.80031082749065, 18539.07304634768, 18804.34184803532, 19196.0, 19486.317978870742, 19513.219471221135, 14426.927865360685, 17702.67229957752, 19397.806021939778, 20537.178512859504, 20689.275875344367, 5596.972015139919, 5876.118582212681, 5927.140564618127, 5935.465808077272, 5944.2866855977345, 4169.374593810938, 5742.79900203493, 6209.720562574673, 6516.0, 6522.641254730988, 6003.249593800775, 6065.878682426349, 6430.871382572346, 6440.967795161017, 6497.93502064978, 6153.35389784073, 6402.199725034371, 6404.455621272197, 6427.325130861263, 6430.356964303555, 5318.654287471302, 5522.8678120985505, 5528.5024347808485, 5539.8892022159735, 5548.77804887804, 12536.0, 13173.209607423489, 24323.87838060816, 24424.87787561051, 24462.388440288956, 1997.7203191553194, 2020.6160829442358, 2123.6389813731703, 2232.2410380470556, 2497.5629264878576, 9853.0, 9942.502874856229, 10554.577816887315, 12043.976262017739, 14567.271636418136, 1652.6694661067713, 1666.067002478616, 1722.5607470095047, 1738.0701324791303, 1753.7018706819872, 107653.0, 111796.44101779521, 112180.0, 113328.0, 113477.29784053164, 11338.716532086599, 11523.884761152449, 11583.710407239718, 11611.76776464466, 11668.94165529167, 13805.51680691171, 13859.237741924291, 13866.791998120036, 13873.236971966437, 13900.0, 8260.215279548433, 8420.452670576393, 8430.114837941928, 8508.106648801786, 8509.425756235116, 7778.299953004257, 8466.661333546712, 8530.232279094911, 8595.269402100766, 8604.48373097616, 4358.956410435919, 4470.754108524063, 4480.327950807405, 4496.5503449655425, 4497.955020449819, 1737.869659775522, 1812.7915289741848, 1855.3135339924315, 1870.5978214683907, 1893.9337123200899, 883.9204471597459, 956.8660387545749, 957.593022965237, 962.1484985787629, 994.3834822410007, 18947.336843210698, 19909.0, 19910.701339479918, 19953.60092798165, 20220.0, 951.8143961927497, 956.6030097509595, 971.4754032822339, 991.3853410885297, 1032.3599368391644, 10527.20817043007, 10724.946375268073, 10804.297720648132, 10805.513751881184, 10883.67348979532, 591384.0, 600977.0, 604067.0, 606444.0, 613780.0, 111967.88032119737, 112643.87356126333, 116664.8333516654, 119853.0, 120883.39558302329, 925.9629614815467, 982.6315131825565, 1000.9449480278655, 1003.1272792670278, 1008.5763979128784, 17480.65038699244, 17513.21190546403, 17648.73526897123, 17936.910315448862, 18026.90986545059, 49586.0, 50754.95470271796, 50764.238536421246, 51423.48576514187, 51895.0, 70663.64668176626, 71095.0, 71183.28816711767, 71870.0, 73186.0, 7857.882131768142, 8092.433529652868, 8096.230858068474, 8121.187881211831, 8478.915210847812, 9655.710328690151, 10913.581234439473, 12467.93766031164, 12506.062045346818, 13076.280804555841, 9333.486658233862, 9720.979297173695, 11101.888981110085, 11691.707707307385, 11709.473073711873, 11277.830832537682, 11318.490667920129, 11416.486258118239, 11545.942270288595, 11623.709407264885, 11641.301521908712, 11754.05967522579, 11824.940875295568, 11852.703682407664, 11987.34069626179, 7779.922200778146, 8070.394720395876, 8177.386695997943, 8300.792480188044, 8415.705450309455, 10993.835092473459, 11631.243969141979, 11659.475323610288, 11692.590759323382, 11754.353510557], "unit": "score", "name": "jquery.html", "value": 9365.500926687317}, {"lowerIsBetter": false, "replicates": [1413.4982081361118, 1565.7964464619602, 1773.6009397885477, 1913.6268427656603, 1922.9519262018457, 7855.253750893656, 8485.0, 8603.0, 8744.606492707835, 8830.86753698695, 8596.8710469343, 8601.784955376119, 8657.307415406769, 8695.34784891134, 8700.956495217531, 2375.6911601491825, 2400.9159679411223, 2406.2660888429023, 2410.842795458181, 2411.0958390603523, 2440.6583078369044, 2470.950580988379, 2482.2429159106464, 2487.253823852837, 2488.054539275073, 2456.9262922112366, 2463.9137630182945, 2472.5673007223754, 2479.5536803375385, 2488.776010159085, 2430.8257027151103, 2444.0712529238863, 2456.4841383309526, 2470.2218801077784, 2473.6165894286323, 2160.5894879972757, 2196.0666716645524, 2196.7144271244797, 2197.6593627987686, 2202.218212534543, 8775.561221938877, 8788.252998495072, 8797.736067917973, 8848.513331766815, 8862.778430539223, 4623.42207224097, 5411.675299482044, 5478.397376288645, 5495.313085864267, 5501.779928802843, 2969.420962912233, 3553.6091029986683, 3557.3596752584526, 3614.1868079682126, 3630.6550877666577, 1055.113704488226, 1068.086785798139, 1069.2461814420815, 1070.0423121306387, 1070.4433694478828, 11353.489092990836, 11687.532498700042, 11712.765744685144, 11813.350265735382, 11865.991390731799, 4821.662483626183, 4902.14212512816, 4964.801407943714, 4970.925436118461, 4980.003999200102, 10135.797284054424, 10159.644412445528, 10167.983201679774, 10177.0, 10187.0, 5465.754041068161, 5489.094299440628, 5524.806631767869, 5540.445955404508, 5543.556515478752, 4408.713433626804, 4841.201201801663, 4978.90042199154, 4982.800687972441, 5015.573676237488, 3557.8043207623828, 3836.654701076861, 3886.892235712865, 3920.0199950012498, 3972.880813575597, 1303.2376060004813, 1310.5282098444552, 1315.3952178342406, 1316.9012324075732, 1319.3271431569776, 1344.267374281019, 1361.1288775183891, 1366.5558693424678, 1381.7374698807193, 1383.619504636213, 7038.472114591426, 7984.960075199587, 8148.307393871469, 8178.5092894426525, 8202.38482113832, 512.6437126197258, 521.3473289671674, 523.8480840556272, 525.5060243371219, 529.608090013395, 5951.256092988377, 6137.754489820357, 6139.723712432951, 6141.293751218578, 6262.467690246289, 10461.476926153662, 10696.465176741132, 10767.515461804238, 10790.838137427945, 10832.72918177036, 9033.0, 10569.471526423647, 10650.94674526638, 10661.84007239892, 10682.092022178202, 7074.646267686698, 7783.143854176149, 7891.644875980594, 8294.419390642717, 8323.001239851257, 6861.245263020964, 7449.925500744923, 7934.880976785237, 7992.800179995546, 8017.0, 9283.48940808262, 9384.343095983215, 9499.620015199314, 9605.13553780163, 9608.615655373986, 9035.412698174598, 9035.45787252767, 9294.907050929403, 9955.800883982425, 10097.848532272168, 5791.0, 7470.215627359049, 7556.697732090654, 7843.294103530481, 8113.269805717514, 8250.257476827115, 8271.2142346477, 8297.875531867148, 8322.916770832215, 8346.081930987708, 7284.307990740871, 7363.852722945404, 7381.704731810667, 7559.0, 7565.621718913922, 7182.640867956686, 7204.9279507204255, 7272.781816545512, 7315.341619254293, 7368.115826100902, 7786.4160187985, 7798.610069496389, 7821.843563128819, 7825.100113487022, 7828.960855195687, 7012.649367531501, 7045.295470452914, 7052.894206586802, 7116.644167791486, 7125.67934442941, 6157.599756015845, 7135.179454362815, 7164.355208031302, 7165.3909417698, 7175.067241258603], "unit": "score", "name": "mootools.html", "value": 4808.832829816563}, {"lowerIsBetter": false, "replicates": [319.6962885259004, 324.3966222825544, 327.5528903047341, 332.1546663740779, 333.2235890375424, 6793.728250869965, 6814.0, 6835.282295358984, 6870.965645171767, 6917.273686262945, 5369.543588794957, 6666.899996500057, 6791.185057793072, 6792.0, 6823.112995310603, 4744.098621261966, 4830.251311046776, 4915.451632735677, 4962.528559786814, 4968.850934471971, 4927.728974906378, 4936.728479933602, 4941.604671626261, 4963.776630051656, 4965.031818795336, 4875.756212189394, 4890.608751299906, 4908.7300198489065, 4916.803327866881, 4918.704877707331, 4912.164931961575, 4926.9014619707405, 4927.088488629579, 4927.531884470969, 4934.80260789568, 4214.831406743727, 4217.135487225142, 4218.050938538804, 4221.978890105561, 4224.683148763855, 6290.748370065192, 6536.93463065368, 6538.280789113193, 6565.54041217115, 6608.702608382634, 5731.541476681856, 5775.566832487538, 5782.190493330937, 5815.592908496407, 5918.336748463209, 7337.963310183468, 7340.0, 7356.448266379989, 7364.410847132217, 7374.741884034033, 4615.192341340286, 4616.907661846744, 4616.976915115437, 4625.421822272216, 4640.0, 7380.1512826025155, 7676.654550545239, 7750.186230445778, 7765.922340776577, 7821.608919554, 3912.8434862605745, 4569.954300456953, 4590.701604395704, 4678.672492925462, 4694.882627934329, 4738.715677059387, 4744.7390393528685, 4748.786304616231, 4748.810047598057, 4768.785404656799, 5199.324087868553, 5221.190715439113, 5702.2301989231755, 5723.971380143073, 5726.885462290731, 7330.6701198445135, 7332.743353982585, 7346.008288881039, 7356.190819009905, 7366.305749677605, 1644.6957312896914, 1658.9917050414913, 1668.032541126144, 1668.3993762245582, 1669.7829282193238, 859.2610355094614, 890.950997695133, 963.7349728824629, 1017.4658304390107, 1070.2347821307803, 5506.0, 6748.696308666122, 6767.154105736783, 6816.488763342769, 6851.520393572402, 7460.365868901095, 7507.324340809353, 7531.171571127172, 7534.623268836536, 7554.735584254525, 5884.617499862496, 6789.083473730983, 6794.66026698673, 6811.659417029129, 6814.965925170342, 3192.4413227685063, 3921.627445392683, 3934.3114954883354, 3978.8209530571194, 3995.9400608990886, 7982.363615458817, 7983.481073730305, 7999.520028798291, 8050.27547520726, 8053.234942680436, 7927.445078844426, 7932.325752311118, 7938.166492518202, 7942.324902383247, 7960.761177164694, 6569.948808190667, 7885.053793544582, 7977.880331795028, 8041.155678653658, 8061.0, 7272.527285726411, 7587.2412758723685, 7609.239076092346, 7670.117936437381, 7711.537307761552, 7333.266673332838, 7381.630918454163, 7402.407807375289, 7415.555066696015, 7419.1467981180695, 7859.84280314402, 7889.3294070004695, 7906.565138917184, 7910.485818421784, 7926.564038977681, 4645.047765208056, 4688.906221875475, 4701.764911754467, 4718.8584342469785, 4726.740029298284, 7265.803046659453, 7439.70241190368, 7572.734954276574, 7581.0, 7615.5430674157515, 6851.0, 7266.89099663516, 7334.4132469403385, 7356.301151390609, 7368.778936631909, 7280.344768970818, 7331.4134869209265, 7336.4130869529245, 7338.77983660491, 7345.375643070399, 6160.691965401802, 6839.281875403011, 6929.89605155913, 7116.964415177891, 7172.0676312079095, 7313.122425308997, 7344.485885988143, 7361.889571656322, 7376.7049318026675, 7395.852082958203, 7149.964250178716, 7174.0, 7193.568385896863, 7193.892091618734, 7196.856062878818], "unit": "score", "name": "prototype.html", "value": 5256.996926145397}, {"lowerIsBetter": false, "replicates": [581.3808294166715, 622.3962756126557, 666.5534092158257, 669.9430548403385, 727.1456039153996, 12745.171563848344, 14502.274886255684, 15162.924185379085, 15264.389424423038, 15338.46315378962, 13757.449702011907, 13875.236861972588, 14359.712805743879, 14406.711865762678, 14411.78382324266, 702.768086531446, 724.7427163357024, 836.9121242269565, 868.1839071273015, 868.9695860644879, 849.7408290471403, 869.5261082709907, 875.0855356152836, 875.7329014650529, 879.9384043116985, 909.8544232922734, 920.2913756407596, 921.3780698028837, 921.7695576105973, 923.5336155241594, 891.4517571693427, 900.1898291537635, 903.7876099116702, 906.7189171356835, 908.3641450984337, 645.5868244323636, 671.8622682350156, 675.5170053411784, 679.2392520377209, 679.6873438218425, 14817.407303707838, 14932.25338733059, 14983.550493485212, 15097.169655668933, 15148.394064237416, 12810.935945320307, 12820.423080961378, 12975.091743577954, 13034.934825325907, 13168.209907405586, 9798.216142708638, 10036.64871729486, 10062.64780732678, 10147.137493313003, 10445.52995115214, 3458.3083383323437, 3521.1197200699826, 3525.7708248963736, 3574.910627234314, 3687.50218720472, 75216.62391688007, 76486.0, 77201.61399192968, 77263.22736772617, 78039.0, 9439.952800235955, 9466.715998520056, 9475.573599188054, 9568.712938611852, 10029.922202274029, 21501.354959351243, 21531.13875444996, 21614.919254037548, 21629.675554866688, 21640.56718865614, 7361.8159546011775, 7453.440991925628, 7493.775186744407, 7565.167831538526, 7615.5430674158615, 4113.794310284474, 4127.669786417079, 4147.149834283965, 4154.646855017297, 4168.8332466700995, 3478.617352091268, 3483.2336885885065, 3499.107727529464, 3516.1736991806906, 3545.1314427965312, 585.9414058594192, 606.1695477196181, 612.8437248501692, 633.0883527720068, 636.2269842141727, 482.4066398330004, 578.0664227273008, 588.7527238559816, 596.1713218626113, 602.2441835496423, 8151.79620509492, 8249.628766705513, 8327.167283271625, 8434.873476897852, 8458.746237612759, 443.7182389182892, 499.3533374280316, 525.4850246758122, 529.891372268684, 600.4145957691217, 3046.1470788179345, 3901.1027463682944, 3935.3506671399473, 3995.260876737813, 4020.9396859047138, 85236.57381713176, 97867.0, 99286.0, 100829.49585252027, 102308.0, 50901.21845735382, 69236.6538167316, 72486.275137249, 72930.27069729235, 72949.0, 51474.99999999925, 58879.0, 61734.69132654398, 65365.0, 65477.05353259115, 8309.626066827128, 8390.496570205807, 8440.987081550007, 8524.573771311534, 8639.654413823628, 46233.61299161031, 47294.0, 47929.76035119802, 49248.38227974116, 49319.0, 61332.69333653303, 63328.0, 64246.71506569749, 64435.0, 66404.66797665981, 10527.736806579896, 10822.621208257988, 10834.349939003685, 11122.221444499131, 11173.050290725054, 11591.76816463683, 12302.323372214614, 12384.56654017105, 12405.131640785059, 12618.17981831178, 9864.605415783288, 11371.260868043551, 11725.530978761095, 11758.529658813552, 11766.352850592957, 11254.099672026383, 11641.767164656829, 11645.0, 11650.184487085822, 12312.876871231172, 11082.722931926766, 11129.610463633733, 11152.219344645797, 11400.885991140314, 11519.481623327138, 8298.879651247003, 9135.132162444557, 9501.049895010443, 9761.267904907018, 10014.198864091, 9081.863772043293, 9204.263658907405, 9253.398529095588, 9722.270829687943, 9747.25656686049], "unit": "score", "name": "yui.html", "value": 6734.930133570468}], "name": "dromaeo_css", "value": 7484.656947462793}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 115.0, 115.0, 117.0, 162.0, 170.0, 151.0, 116.0, 118.0], "unit": "score", "name": "ai-astar", "value": 128.8}, {"lowerIsBetter": true, "replicates": [174.0, 154.0, 146.0, 155.0, 123.0, 142.0, 142.0, 121.0, 156.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [192.0, 196.0, 205.0, 229.0, 204.0, 203.0, 198.0, 197.0, 205.0, 193.0], "unit": "score", "name": "audio-dft", "value": 202.2}, {"lowerIsBetter": true, "replicates": [75.0, 80.0, 71.0, 111.0, 80.0, 82.0, 82.0, 78.0, 112.0, 59.0], "unit": "score", "name": "audio-fft", "value": 83.0}, {"lowerIsBetter": true, "replicates": [83.0, 88.0, 117.0, 81.0, 81.0, 82.0, 117.0, 76.0, 81.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 92.5}, {"lowerIsBetter": true, "replicates": [88.0, 94.0, 89.0, 95.0, 89.0, 135.0, 86.0, 95.0, 87.0, 95.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.3}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 122.0, 103.0, 152.0, 150.0, 101.0, 140.0], "unit": "score", "name": "imaging-darkroom", "value": 115.6}, {"lowerIsBetter": true, "replicates": [126.0, 78.0, 146.0, 147.0, 109.0, 77.0, 125.0, 77.0, 80.0, 116.0], "unit": "score", "name": "imaging-desaturate", "value": 108.1}, {"lowerIsBetter": true, "replicates": [57.0, 61.0, 60.0, 58.0, 58.0, 57.0, 58.0, 63.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [67.0, 76.0, 63.0, 73.0, 98.0, 69.0, 59.0, 67.0, 91.0, 101.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 76.4}, {"lowerIsBetter": true, "replicates": [95.0, 110.0, 89.0, 108.0, 113.0, 72.0, 96.0, 110.0, 110.0, 76.0], "unit": "score", "name": "stanford-crypto-aes", "value": 97.9}, {"lowerIsBetter": true, "replicates": [136.0, 117.0, 118.0, 151.0, 134.0, 136.0, 128.0, 129.0, 121.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.3}, {"lowerIsBetter": true, "replicates": [136.0, 171.0, 176.0, 142.0, 142.0, 137.0, 163.0, 171.0, 132.0, 173.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.3}, {"lowerIsBetter": true, "replicates": [67.0, 74.0, 95.0, 65.0, 85.0, 93.0, 94.0, 68.0, 82.0, 90.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 81.3}], "name": "kraken", "value": 1567.7}]} 03:30:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1567.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7484.66"}}} 03:30:17 INFO - Return code: 0 03:30:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:30:17 ERROR - # TBPL SUCCESS # 03:30:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:30:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:30:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:30:17 INFO - 2016-02-26 03:30:17.110 screenresolution[1699:10947] starting screenresolution argv=screenresolution get 03:30:17 INFO - 2016-02-26 03:30:17.112 screenresolution[1699:10947] Display 0: 1600x1200x32@60 03:30:17 INFO - 2016-02-26 03:30:17.118 screenresolution[1700:10950] starting screenresolution argv=screenresolution list 03:30:17 INFO - Available Modes on Display 0 03:30:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:30:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:30:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:30:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:30:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:30:17 INFO - Intel Iris: 03:30:17 INFO - Chipset Model: Intel Iris 03:30:17 INFO - Type: GPU 03:30:17 INFO - Bus: Built-In 03:30:17 INFO - VRAM (Dynamic, Max): 1536 MB 03:30:17 INFO - Vendor: Intel (0x8086) 03:30:17 INFO - Device ID: 0x0a2e 03:30:17 INFO - Revision ID: 0x0009 03:30:17 INFO - Displays: 03:30:17 INFO - Display: 03:30:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:30:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:30:17 INFO - Display Serial Number: 1600x1200 60 03:30:17 INFO - Main Display: Yes 03:30:17 INFO - Mirror: Off 03:30:17 INFO - Online: Yes 03:30:17 INFO - Rotation: Supported 03:30:17 INFO - Return code: 0 03:30:17 INFO - Running post-action listener: _resource_record_post_action 03:30:17 INFO - Running post-run listener: _resource_record_post_run 03:30:18 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 33287680; Write bytes: 710532096; Read time: 347; Write time: 2018 03:30:18 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 395584000; Write bytes: 390597632; Read time: 29802; Write time: 734 03:30:18 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 31505920; Write bytes: 302088192; Read time: 329; Write time: 1241 03:30:18 INFO - Running post-run listener: _upload_blobber_files 03:30:18 INFO - Blob upload gear active. 03:30:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:30:18 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 03:30:18 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'] 03:30:18 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 03:30:18 INFO - (blobuploader) - INFO - Open directory for files ... 03:30:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:30:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:30:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:19 INFO - (blobuploader) - INFO - Done attempting. 03:30:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:30:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:30:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:20 INFO - (blobuploader) - INFO - Done attempting. 03:30:20 INFO - (blobuploader) - INFO - Iteration through files over. 03:30:20 INFO - Return code: 0 03:30:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:30:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:30:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbec12153d76698a1e7bb29d344e8216b9ad773fdb306c996fbf4f5bc5c443fe12061ca1809da20f8727c7dc6725bb03c60fa1a03c966cca8ed4c5aaae3c75ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6f5c31e6b05b42229ae7a165a7008f789f279d56b1775a4796079f5dc8923b0ac304fffd3c2782bb791685cc9167ef1d36fcdf8d08c348d62cc9d3da4a91e0d"} 03:30:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:30:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:30:20 INFO - Contents: 03:30:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbec12153d76698a1e7bb29d344e8216b9ad773fdb306c996fbf4f5bc5c443fe12061ca1809da20f8727c7dc6725bb03c60fa1a03c966cca8ed4c5aaae3c75ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6f5c31e6b05b42229ae7a165a7008f789f279d56b1775a4796079f5dc8923b0ac304fffd3c2782bb791685cc9167ef1d36fcdf8d08c348d62cc9d3da4a91e0d"} 03:30:20 INFO - Running post-run listener: copy_logs_to_upload_dir 03:30:20 INFO - Copying logs to upload dir... 03:30:20 INFO - mkdir: /builds/slave/test/build/upload/logs 03:30:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.981596 ========= master_lag: 1.93 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-02-26 03:30:22.917710) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 03:30:22.921717) ========= 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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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/cbec12153d76698a1e7bb29d344e8216b9ad773fdb306c996fbf4f5bc5c443fe12061ca1809da20f8727c7dc6725bb03c60fa1a03c966cca8ed4c5aaae3c75ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6f5c31e6b05b42229ae7a165a7008f789f279d56b1775a4796079f5dc8923b0ac304fffd3c2782bb791685cc9167ef1d36fcdf8d08c348d62cc9d3da4a91e0d"} build_url:https://queue.taskcluster.net/v1/task/MhjeGgKEQuWx-o7opuL9Wg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010896 build_url: 'https://queue.taskcluster.net/v1/task/MhjeGgKEQuWx-o7opuL9Wg/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/cbec12153d76698a1e7bb29d344e8216b9ad773fdb306c996fbf4f5bc5c443fe12061ca1809da20f8727c7dc6725bb03c60fa1a03c966cca8ed4c5aaae3c75ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6f5c31e6b05b42229ae7a165a7008f789f279d56b1775a4796079f5dc8923b0ac304fffd3c2782bb791685cc9167ef1d36fcdf8d08c348d62cc9d3da4a91e0d"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 03:30:22.970233) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 7 secs) (at 2016-02-26 03:30:22.970522) ========= 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.2YIVvUKfZ3/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.bzzwCiKUMI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.005140 ========= master_lag: 7.32 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 7 secs) (at 2016-02-26 03:30:30.296636) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 03:30:30.296955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 03:30:30.396926) ========= ========= Total master_lag: 9.47 =========