builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0142 starttime: 1458613764.8 results: success (0) buildid: 20160321172928 builduid: 8628fcff3fda4cefbb90457aeb7bd1d7 revision: 98189434eea16c181df0c7e8d60af76feceaf492 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:24.795471) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:24.795906) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:24.796191) ========= 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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.005259 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:24.820444) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:24.820735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:24.837871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:24.838247) ========= 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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.005377 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:24.888825) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:24.889451) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:24.890311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:24.890992) ========= 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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-21 19:29:24-- 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% 141M=0s 2016-03-21 19:29:25 (141 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177593 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:25.085910) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:25.086222) ========= 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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.026143 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:25.134437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-21 19:29:25.134797) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98189434eea16c181df0c7e8d60af76feceaf492 --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 98189434eea16c181df0c7e8d60af76feceaf492 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kpE5WmieyZ/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.P2RyMVOFSr/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-21 19:29:25,209 truncating revision to first 12 chars 2016-03-21 19:29:25,209 Setting DEBUG logging. 2016-03-21 19:29:25,209 attempt 1/10 2016-03-21 19:29:25,209 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98189434eea1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-21 19:29:26,180 unpacking tar archive at: fx-team-98189434eea1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.219338 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-21 19:29:26.374414) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:26.375179) ========= echo 98189434eea16c181df0c7e8d60af76feceaf492 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'98189434eea16c181df0c7e8d60af76feceaf492'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kpE5WmieyZ/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.P2RyMVOFSr/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 98189434eea16c181df0c7e8d60af76feceaf492 program finished with exit code 0 elapsedTime=0.005282 script_repo_revision: '98189434eea16c181df0c7e8d60af76feceaf492' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:26.428127) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:26.428868) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 19:29:26.444766) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-21 19:29:26.445033) ========= /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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:29:26 INFO - MultiFileLogger online at 20160321 19:29:26 in /builds/slave/test 19:29:26 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 19:29:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:29:26 INFO - {'append_to_log': False, 19:29:26 INFO - 'base_work_dir': '/builds/slave/test', 19:29:26 INFO - 'blob_upload_branch': 'Fx-Team', 19:29:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:29:26 INFO - 'branch': 'Fx-Team', 19:29:26 INFO - 'buildbot_json_path': 'buildprops.json', 19:29:26 INFO - 'config_files': ('talos/mac_config.py',), 19:29:26 INFO - 'default_actions': ('clobber', 19:29:26 INFO - 'read-buildbot-config', 19:29:26 INFO - 'download-and-extract', 19:29:26 INFO - 'populate-webroot', 19:29:26 INFO - 'create-virtualenv', 19:29:26 INFO - 'install', 19:29:26 INFO - 'run-tests'), 19:29:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:29:26 INFO - 'download_minidump_stackwalk': True, 19:29:26 INFO - 'download_symbols': 'ondemand', 19:29:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:29:26 INFO - 'tooltool.py': '/tools/tooltool.py', 19:29:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:29:26 INFO - '/tools/misc-python/virtualenv.py')}, 19:29:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:29:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:29:26 INFO - 'installer_path': 'installer.exe', 19:29:26 INFO - 'log_level': 'info', 19:29:26 INFO - 'log_name': 'talos', 19:29:26 INFO - 'log_to_console': True, 19:29:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:29:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:29:26 INFO - 'opt_config_files': (), 19:29:26 INFO - 'pip_index': False, 19:29:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:29:26 INFO - 'cmd': ('bash', 19:29:26 INFO - '-c', 19:29:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:29:26 INFO - 'enabled': True, 19:29:26 INFO - 'halt_on_failure': False, 19:29:26 INFO - 'name': 'check_screen_resolution'},), 19:29:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:29:26 INFO - 'cmd': ('bash', 19:29:26 INFO - '-c', 19:29:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:29:26 INFO - 'enabled': True, 19:29:26 INFO - 'halt_on_failure': False, 19:29:26 INFO - 'name': 'check_screen_resolution'},), 19:29:26 INFO - 'run_cmd_checks_enabled': True, 19:29:26 INFO - 'sps_profile': False, 19:29:26 INFO - 'sps_profile_interval': 0, 19:29:26 INFO - 'suite': 'dromaeojs-e10s', 19:29:26 INFO - 'system_bits': '32', 19:29:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:29:26 INFO - 'title': 't-yosemite-r7-0142', 19:29:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:29:26 INFO - 'use_talos_json': True, 19:29:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:29:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:29:26 INFO - 'work_dir': 'build'} 19:29:26 INFO - ##### 19:29:26 INFO - ##### Running clobber step. 19:29:26 INFO - ##### 19:29:26 INFO - Running pre-action listener: _resource_record_pre_action 19:29:26 INFO - Running main action method: clobber 19:29:26 INFO - rmtree: /builds/slave/test/build 19:29:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:29:28 INFO - Running post-action listener: _resource_record_post_action 19:29:28 INFO - ##### 19:29:28 INFO - ##### Running read-buildbot-config step. 19:29:28 INFO - ##### 19:29:28 INFO - Running pre-action listener: _resource_record_pre_action 19:29:28 INFO - Running main action method: read_buildbot_config 19:29:28 INFO - Using buildbot properties: 19:29:28 INFO - { 19:29:28 INFO - "project": "", 19:29:28 INFO - "product": "firefox", 19:29:28 INFO - "script_repo_revision": "production", 19:29:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 19:29:28 INFO - "repository": "", 19:29:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 19:29:28 INFO - "buildid": "20160321172928", 19:29:28 INFO - "pgo_build": "False", 19:29:28 INFO - "basedir": "/builds/slave/test", 19:29:28 INFO - "buildnumber": 524, 19:29:28 INFO - "slavename": "t-yosemite-r7-0142", 19:29:28 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 19:29:28 INFO - "platform": "yosemite_r7", 19:29:28 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 19:29:28 INFO - "branch": "fx-team", 19:29:28 INFO - "repo_path": "integration/fx-team", 19:29:28 INFO - "revision": "98189434eea16c181df0c7e8d60af76feceaf492", 19:29:28 INFO - "stage_platform": "macosx64", 19:29:28 INFO - "builduid": "8628fcff3fda4cefbb90457aeb7bd1d7", 19:29:28 INFO - "slavebuilddir": "test" 19:29:28 INFO - } 19:29:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 19:29:28 INFO - Running post-action listener: _resource_record_post_action 19:29:28 INFO - ##### 19:29:28 INFO - ##### Running download-and-extract step. 19:29:28 INFO - ##### 19:29:28 INFO - Running pre-action listener: _resource_record_pre_action 19:29:28 INFO - Running main action method: download_and_extract 19:29:28 INFO - mkdir: /builds/slave/test/build/tests 19:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:29:28 INFO - https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:29:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 19:29:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 19:29:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 19:29:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 19:29:29 INFO - Downloaded 1199 bytes. 19:29:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 19:29:29 INFO - Using the following test package requirements: 19:29:29 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 19:29:29 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:29:29 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 19:29:29 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:29:29 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 19:29:29 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:29:29 INFO - u'jsshell-mac.zip'], 19:29:29 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:29:29 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 19:29:29 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 19:29:29 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:29:29 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 19:29:29 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:29:29 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 19:29:29 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:29:29 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 19:29:29 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:29:29 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 19:29:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:29:29 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')]} 19:29:29 INFO - https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:29:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:29:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:29:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:29:30 INFO - Downloaded 17858441 bytes. 19:29:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:29:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:29:33 INFO - Return code: 0 19:29:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:29:33 INFO - https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:29:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:29:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:29:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:29:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:29:34 INFO - Downloaded 17858441 bytes. 19:29:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:29:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:29:38 INFO - Return code: 0 19:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:29:38 INFO - https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:29:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:29:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:29:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:29:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:29:39 INFO - Downloaded 10847637 bytes. 19:29:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:29:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:29:39 INFO - Return code: 0 19:29: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')]} 19:29:39 INFO - https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:29:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:29:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:29:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 19:29:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 19:29:42 INFO - Downloaded 111258428 bytes. 19:29:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:29:42 INFO - mkdir: /builds/slave/test/properties 19:29:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:29:42 INFO - Writing to file /builds/slave/test/properties/build_url 19:29:42 INFO - Contents: 19:29:42 INFO - build_url:https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:29:44 INFO - Running post-action listener: _resource_record_post_action 19:29:44 INFO - Running post-action listener: set_extra_try_arguments 19:29:44 INFO - ##### 19:29:44 INFO - ##### Running populate-webroot step. 19:29:44 INFO - ##### 19:29:44 INFO - Running pre-action listener: _resource_record_pre_action 19:29:44 INFO - Running main action method: populate_webroot 19:29:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:29:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:29:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:29:44 INFO - '--tppagecycles', 19:29:44 INFO - '7'], 19:29:44 INFO - 'tests': ['tsvgm']}}, 19:29:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:29:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:29:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:29:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:29:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:29:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:29:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:29:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:44 INFO - 'talos_options': ['--e10s'], 19:29:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:29:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:44 INFO - 'tests': ['damp', 'tps']}, 19:29:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:44 INFO - 'talos_options': ['--e10s'], 19:29:44 INFO - 'tests': ['damp', 'tps']}, 19:29:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:29:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:29:44 INFO - 'other': {'tests': ['a11yr', 19:29:44 INFO - 'ts_paint', 19:29:44 INFO - 'tpaint', 19:29:44 INFO - 'sessionrestore', 19:29:44 INFO - 'sessionrestore_no_auto_restore', 19:29:44 INFO - 'tabpaint']}, 19:29:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:29:44 INFO - 'tests': ['a11yr', 19:29:44 INFO - 'ts_paint', 19:29:44 INFO - 'tpaint', 19:29:44 INFO - 'sessionrestore', 19:29:44 INFO - 'sessionrestore_no_auto_restore', 19:29:44 INFO - 'tabpaint']}, 19:29:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:29:44 INFO - 'tests': ['a11yr', 19:29:44 INFO - 'ts_paint', 19:29:44 INFO - 'tpaint', 19:29:44 INFO - 'sessionrestore', 19:29:44 INFO - 'sessionrestore_no_auto_restore', 19:29:44 INFO - 'tabpaint']}, 19:29:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:29:44 INFO - 'tests': ['a11yr', 19:29:44 INFO - 'ts_paint', 19:29:44 INFO - 'tpaint', 19:29:44 INFO - 'sessionrestore', 19:29:44 INFO - 'sessionrestore_no_auto_restore', 19:29:44 INFO - 'tabpaint']}, 19:29:44 INFO - 'other_l64': {'tests': ['a11yr', 19:29:44 INFO - 'ts_paint', 19:29:44 INFO - 'tpaint', 19:29:44 INFO - 'sessionrestore', 19:29:44 INFO - 'sessionrestore_no_auto_restore', 19:29:44 INFO - 'tabpaint']}, 19:29:44 INFO - 'other_nol64': {'tests': ['a11yr', 19:29:44 INFO - 'ts_paint', 19:29:44 INFO - 'tpaint', 19:29:44 INFO - 'sessionrestore', 19:29:44 INFO - 'sessionrestore_no_auto_restore', 19:29:44 INFO - 'tabpaint']}, 19:29:44 INFO - 'svgr': {'tests': ['tsvgx', 19:29:44 INFO - 'tsvgr_opacity', 19:29:44 INFO - 'tart', 19:29:44 INFO - 'tscrollx', 19:29:44 INFO - 'cart']}, 19:29:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:29:44 INFO - 'tests': ['tsvgx', 19:29:44 INFO - 'tsvgr_opacity', 19:29:44 INFO - 'tart', 19:29:44 INFO - 'tscrollx', 19:29:44 INFO - 'cart']}, 19:29:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:44 INFO - 'tests': ['tp5o']}, 19:29:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:44 INFO - 'talos_options': ['--e10s'], 19:29:44 INFO - 'tests': ['tp5o']}, 19:29:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:44 INFO - 'talos_options': ['--xperf_path', 19:29:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:29:44 INFO - 'tests': ['tp5n']}, 19:29:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:29:44 INFO - 'talos_options': ['--e10s', 19:29:44 INFO - '--xperf_path', 19:29:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:29:44 INFO - 'tests': ['tp5n']}}, 19:29:44 INFO - 'talos.zip': {'path': '', 19:29:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:29:44 INFO - Running post-action listener: _resource_record_post_action 19:29:44 INFO - ##### 19:29:44 INFO - ##### Running create-virtualenv step. 19:29:44 INFO - ##### 19:29:44 INFO - Running pre-action listener: _resource_record_pre_action 19:29:44 INFO - Running main action method: create_virtualenv 19:29:44 INFO - Creating virtualenv /builds/slave/test/build/venv 19:29:44 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 19:29:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:29:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:29:44 INFO - Using real prefix '/tools/python27' 19:29:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:29:44 INFO - Installing distribute.............................................................................................................................................................................................done. 19:29:47 INFO - Installing pip.................done. 19:29:47 INFO - Return code: 0 19:29:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:29: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')]} 19:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29: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')]} 19:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b2a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8de14a3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b141e00>, '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 0x10afaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b13cb20>, '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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:29: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', 'pip>=1.5'] in /builds/slave/test/build 19:29: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 pip>=1.5 19:29:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kpE5WmieyZ/Render', 19:29:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:29:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:29:47 INFO - 'HOME': '/Users/cltbld', 19:29:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:29:47 INFO - 'LOGNAME': 'cltbld', 19:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:47 INFO - 'MOZ_NO_REMOTE': '1', 19:29:47 INFO - 'NO_EM_RESTART': '1', 19:29:47 INFO - 'PAGER': '/bin/cat', 19:29:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:47 INFO - 'PWD': '/builds/slave/test', 19:29:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:29:47 INFO - 'SHELL': '/bin/bash', 19:29:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2RyMVOFSr/Listeners', 19:29:47 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:29:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:29:47 INFO - 'USER': 'cltbld', 19:29:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:29:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:47 INFO - 'XPC_FLAGS': '0x0', 19:29:47 INFO - 'XPC_SERVICE_NAME': '0', 19:29:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:48 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 19:29:48 INFO - Cleaning up... 19:29:48 INFO - Return code: 0 19:29:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:48 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 0x10b2a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8de14a3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b141e00>, '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 0x10afaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b13cb20>, '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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:29:48 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 19:29:48 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 19:29:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kpE5WmieyZ/Render', 19:29:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:29:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:29:48 INFO - 'HOME': '/Users/cltbld', 19:29:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:29:48 INFO - 'LOGNAME': 'cltbld', 19:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:48 INFO - 'MOZ_NO_REMOTE': '1', 19:29:48 INFO - 'NO_EM_RESTART': '1', 19:29:48 INFO - 'PAGER': '/bin/cat', 19:29:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:48 INFO - 'PWD': '/builds/slave/test', 19:29:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:29:48 INFO - 'SHELL': '/bin/bash', 19:29:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2RyMVOFSr/Listeners', 19:29:48 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:29:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:29:48 INFO - 'USER': 'cltbld', 19:29:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:29:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:48 INFO - 'XPC_FLAGS': '0x0', 19:29:48 INFO - 'XPC_SERVICE_NAME': '0', 19:29:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:48 INFO - Downloading/unpacking psutil>=0.7.1 19:29:48 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 19:29:48 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 19:29:48 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 19:29:48 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 19:29:48 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 19:29:48 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 19:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:29:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:29:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:29:51 INFO - Installing collected packages: psutil 19:29:51 INFO - Running setup.py install for psutil 19:29:51 INFO - building 'psutil._psutil_osx' extension 19:29:51 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 19:29:51 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 19:29:51 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 19:29:52 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 19:29:52 INFO - building 'psutil._psutil_posix' extension 19:29:52 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 19:29:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:29:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:29:52 INFO - ^ 19:29:52 INFO - 1 warning generated. 19:29:52 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 19:29:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:29:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:29:52 INFO - Successfully installed psutil 19:29:52 INFO - Cleaning up... 19:29:52 INFO - Return code: 0 19:29:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:29: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')]} 19:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29: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')]} 19:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:52 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 0x10b2a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8de14a3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b141e00>, '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 0x10afaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b13cb20>, '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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:29:52 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 19:29:52 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 19:29:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kpE5WmieyZ/Render', 19:29:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:29:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:29:52 INFO - 'HOME': '/Users/cltbld', 19:29:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:29:52 INFO - 'LOGNAME': 'cltbld', 19:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:52 INFO - 'MOZ_NO_REMOTE': '1', 19:29:52 INFO - 'NO_EM_RESTART': '1', 19:29:52 INFO - 'PAGER': '/bin/cat', 19:29:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:52 INFO - 'PWD': '/builds/slave/test', 19:29:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:29:52 INFO - 'SHELL': '/bin/bash', 19:29:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2RyMVOFSr/Listeners', 19:29:52 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:29:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:29:52 INFO - 'USER': 'cltbld', 19:29:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:29:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:52 INFO - 'XPC_FLAGS': '0x0', 19:29:52 INFO - 'XPC_SERVICE_NAME': '0', 19:29:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:29:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:29:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:29:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:29:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:29:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:29:55 INFO - Installing collected packages: mozsystemmonitor 19:29:55 INFO - Running setup.py install for mozsystemmonitor 19:29:55 INFO - Successfully installed mozsystemmonitor 19:29:55 INFO - Cleaning up... 19:29:55 INFO - Return code: 0 19:29:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b2a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8de14a3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b141e00>, '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 0x10afaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b13cb20>, '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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:29:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:29:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kpE5WmieyZ/Render', 19:29:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:29:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:29:55 INFO - 'HOME': '/Users/cltbld', 19:29:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:29:55 INFO - 'LOGNAME': 'cltbld', 19:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:55 INFO - 'MOZ_NO_REMOTE': '1', 19:29:55 INFO - 'NO_EM_RESTART': '1', 19:29:55 INFO - 'PAGER': '/bin/cat', 19:29:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:55 INFO - 'PWD': '/builds/slave/test', 19:29:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:29:55 INFO - 'SHELL': '/bin/bash', 19:29:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2RyMVOFSr/Listeners', 19:29:55 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:29:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:29:55 INFO - 'USER': 'cltbld', 19:29:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:29:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:55 INFO - 'XPC_FLAGS': '0x0', 19:29:55 INFO - 'XPC_SERVICE_NAME': '0', 19:29:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:55 INFO - Downloading/unpacking blobuploader==1.2.4 19:29:55 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 19:29:55 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 19:29:55 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 19:29:55 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 19:29:55 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 19:29:55 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 19:29:57 INFO - Downloading blobuploader-1.2.4.tar.gz 19:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:29:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:29: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 19:29: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 19:29: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 19:29: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 19:29: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 19:29: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 19:29:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:29:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:29: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 19:29: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 19:29: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 19:29: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 19:29: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 19:29: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 19:29:59 INFO - Downloading docopt-0.6.1.tar.gz 19:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:29:59 INFO - Installing collected packages: blobuploader, requests, docopt 19:29:59 INFO - Running setup.py install for blobuploader 19:29:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:29:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:29:59 INFO - Running setup.py install for requests 19:29:59 INFO - Running setup.py install for docopt 19:30:00 INFO - Successfully installed blobuploader requests docopt 19:30:00 INFO - Cleaning up... 19:30:00 INFO - Return code: 0 19:30:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30:00 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')]} 19:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:00 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')]} 19:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:00 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 0x10b2a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8de14a3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b141e00>, '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 0x10afaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b13cb20>, '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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:30:00 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 19:30:00 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 19:30:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kpE5WmieyZ/Render', 19:30:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:30:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:30:00 INFO - 'HOME': '/Users/cltbld', 19:30:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:30:00 INFO - 'LOGNAME': 'cltbld', 19:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:00 INFO - 'MOZ_NO_REMOTE': '1', 19:30:00 INFO - 'NO_EM_RESTART': '1', 19:30:00 INFO - 'PAGER': '/bin/cat', 19:30:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:00 INFO - 'PWD': '/builds/slave/test', 19:30:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:30:00 INFO - 'SHELL': '/bin/bash', 19:30:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2RyMVOFSr/Listeners', 19:30:00 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:30:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:30:00 INFO - 'USER': 'cltbld', 19:30:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:30:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:00 INFO - 'XPC_FLAGS': '0x0', 19:30:00 INFO - 'XPC_SERVICE_NAME': '0', 19:30:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:30:00 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-qHhw4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:30:00 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-tN4Niw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:30:00 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-JonALH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:30:00 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-pFBCvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:30:00 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-kW6B1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:30:00 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Jm6bpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:30:01 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-UmofxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:30:01 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-BCpYqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:30:01 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-WSf13D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:30:01 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Sp8GKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:30:01 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-cnIZ9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:30:01 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-rgoicB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:30:01 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-3E08Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:30:01 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-msgDPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:01 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-DFApzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:30:01 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-hllyf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:30:02 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-ha_jFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:30:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:30:02 INFO - Running setup.py install for manifestparser 19:30:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:30:02 INFO - Running setup.py install for mozcrash 19:30:02 INFO - Running setup.py install for mozdebug 19:30:02 INFO - Running setup.py install for mozdevice 19:30:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:30:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:30:02 INFO - Running setup.py install for mozfile 19:30:02 INFO - Running setup.py install for mozhttpd 19:30:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:30:03 INFO - Running setup.py install for mozinfo 19:30:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:30:03 INFO - Running setup.py install for mozInstall 19:30:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:30:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:30:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:30:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:30:03 INFO - Running setup.py install for mozleak 19:30:03 INFO - Running setup.py install for mozlog 19:30:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:30:03 INFO - Running setup.py install for moznetwork 19:30:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:30:03 INFO - Running setup.py install for mozprocess 19:30:03 INFO - Running setup.py install for mozprofile 19:30:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:30:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:30:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:30:04 INFO - Running setup.py install for mozrunner 19:30:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:30:04 INFO - Running setup.py install for mozscreenshot 19:30:04 INFO - Running setup.py install for moztest 19:30:04 INFO - Running setup.py install for mozversion 19:30:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:30:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:30:04 INFO - Cleaning up... 19:30:04 INFO - Return code: 0 19:30:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30:04 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')]} 19:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:04 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')]} 19:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:04 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 0x10b2a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8de14a3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b141e00>, '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 0x10afaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b13cb20>, '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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:30:04 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 19:30:04 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 19:30:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kpE5WmieyZ/Render', 19:30:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:30:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:30:04 INFO - 'HOME': '/Users/cltbld', 19:30:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:30:04 INFO - 'LOGNAME': 'cltbld', 19:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:04 INFO - 'MOZ_NO_REMOTE': '1', 19:30:04 INFO - 'NO_EM_RESTART': '1', 19:30:04 INFO - 'PAGER': '/bin/cat', 19:30:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:04 INFO - 'PWD': '/builds/slave/test', 19:30:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:30:04 INFO - 'SHELL': '/bin/bash', 19:30:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2RyMVOFSr/Listeners', 19:30:04 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:30:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:30:04 INFO - 'USER': 'cltbld', 19:30:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:30:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:04 INFO - 'XPC_FLAGS': '0x0', 19:30:04 INFO - 'XPC_SERVICE_NAME': '0', 19:30:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:30:05 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-5JvbW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:30:05 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)) 19:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:30:05 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-g9eyQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 19:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:30:05 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-SfeMJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:30:05 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)) 19:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:30:05 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-SSMgAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:30:05 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)) 19:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:30:05 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-B48zQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:30:05 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)) 19:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:30:05 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-cxy5eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:30:05 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)) 19:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:30:05 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-5GIb7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:30:05 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)) 19:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:30:05 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-EkEt8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:30:05 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)) 19:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:30:05 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-QKhnlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:30:06 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)) 19:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:30:06 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-yjHZ4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:30:06 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)) 19:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:30:06 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-8sQQ9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:30:06 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)) 19:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:30:06 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-lpJ7eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:30:06 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)) 19:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:30:06 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-ulNct9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:30:06 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)) 19:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:30:06 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-QZjPoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:30:06 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)) 19:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:06 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-sT9dHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:06 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)) 19:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:30:06 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-cqDwHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:30:06 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)) 19:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:30:06 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-cqC7zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:30:06 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)) 19:30:06 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:30:06 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:30:06 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)) 19:30:06 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)) 19:30:06 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)) 19:30:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:30: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 19:30: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 19:30: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 19:30: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 19:30: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 19:30: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 19:30:09 INFO - Downloading blessings-1.6.tar.gz 19:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:30:09 INFO - Installing collected packages: blessings 19:30:09 INFO - Running setup.py install for blessings 19:30:09 INFO - Successfully installed blessings 19:30:09 INFO - Cleaning up... 19:30:09 INFO - Return code: 0 19:30:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:30:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:30:09 INFO - Reading from file tmpfile_stdout 19:30:09 INFO - Current package versions: 19:30:09 INFO - blessings == 1.6 19:30:09 INFO - blobuploader == 1.2.4 19:30:09 INFO - docopt == 0.6.1 19:30:09 INFO - manifestparser == 1.1 19:30:09 INFO - mozInstall == 1.12 19:30:09 INFO - mozcrash == 0.17 19:30:09 INFO - mozdebug == 0.1 19:30:09 INFO - mozdevice == 0.48 19:30:09 INFO - mozfile == 1.2 19:30:09 INFO - mozhttpd == 0.7 19:30:09 INFO - mozinfo == 0.9 19:30:09 INFO - mozleak == 0.1 19:30:09 INFO - mozlog == 3.1 19:30:09 INFO - moznetwork == 0.27 19:30:09 INFO - mozprocess == 0.22 19:30:09 INFO - mozprofile == 0.28 19:30:09 INFO - mozrunner == 6.11 19:30:09 INFO - mozscreenshot == 0.1 19:30:09 INFO - mozsystemmonitor == 0.0 19:30:09 INFO - moztest == 0.7 19:30:09 INFO - mozversion == 1.4 19:30:09 INFO - psutil == 3.1.1 19:30:09 INFO - requests == 1.2.3 19:30:09 INFO - wsgiref == 0.1.2 19:30:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:09 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 0x10b2a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8de14a3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b141e00>, '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 0x10afaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b13cb20>, '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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:30:09 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 19:30:09 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 19:30:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kpE5WmieyZ/Render', 19:30:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:30:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:30:09 INFO - 'HOME': '/Users/cltbld', 19:30:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:30:09 INFO - 'LOGNAME': 'cltbld', 19:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:09 INFO - 'MOZ_NO_REMOTE': '1', 19:30:09 INFO - 'NO_EM_RESTART': '1', 19:30:09 INFO - 'PAGER': '/bin/cat', 19:30:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:09 INFO - 'PWD': '/builds/slave/test', 19:30:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:30:09 INFO - 'SHELL': '/bin/bash', 19:30:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2RyMVOFSr/Listeners', 19:30:09 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:30:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:30:09 INFO - 'USER': 'cltbld', 19:30:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:30:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:09 INFO - 'XPC_FLAGS': '0x0', 19:30:09 INFO - 'XPC_SERVICE_NAME': '0', 19:30:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:10 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)) 19:30:10 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)) 19:30:10 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)) 19:30:10 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)) 19:30:10 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)) 19:30:10 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)) 19:30:10 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)) 19:30:10 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)) 19:30:10 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)) 19:30:10 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)) 19:30:10 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)) 19:30:10 INFO - Cleaning up... 19:30:10 INFO - Return code: 0 19:30:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:10 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 0x10b2a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8de14a3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b141e00>, '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 0x10afaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b13cb20>, '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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:30:10 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 19:30:10 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 19:30:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kpE5WmieyZ/Render', 19:30:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:30:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:30:10 INFO - 'HOME': '/Users/cltbld', 19:30:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:30:10 INFO - 'LOGNAME': 'cltbld', 19:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:10 INFO - 'MOZ_NO_REMOTE': '1', 19:30:10 INFO - 'NO_EM_RESTART': '1', 19:30:10 INFO - 'PAGER': '/bin/cat', 19:30:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:10 INFO - 'PWD': '/builds/slave/test', 19:30:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:30:10 INFO - 'SHELL': '/bin/bash', 19:30:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2RyMVOFSr/Listeners', 19:30:10 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:30:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:30:10 INFO - 'USER': 'cltbld', 19:30:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:30:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:10 INFO - 'XPC_FLAGS': '0x0', 19:30:10 INFO - 'XPC_SERVICE_NAME': '0', 19:30:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:10 INFO - Downloading/unpacking jsonschema 19:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:30:12 INFO - Downloading/unpacking functools32 (from jsonschema) 19:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:13 INFO - Downloading functools32-3.2.3-2.tar.gz 19:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:30:13 INFO - warning: no files found matching '*.txt' 19:30:13 INFO - no previously-included directories found matching 'build' 19:30:13 INFO - no previously-included directories found matching 'dist' 19:30:13 INFO - no previously-included directories found matching '.git*' 19:30:13 INFO - Installing collected packages: jsonschema, functools32 19:30:13 INFO - Running setup.py install for functools32 19:30:13 INFO - warning: no files found matching '*.txt' 19:30:13 INFO - no previously-included directories found matching 'build' 19:30:13 INFO - no previously-included directories found matching 'dist' 19:30:13 INFO - no previously-included directories found matching '.git*' 19:30:13 INFO - Successfully installed jsonschema functools32 19:30:13 INFO - Cleaning up... 19:30:13 INFO - Return code: 0 19:30:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:13 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 0x10b2a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2b2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8de14a3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b141e00>, '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 0x10afaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b13cb20>, '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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:30:13 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 19:30:13 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 19:30:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kpE5WmieyZ/Render', 19:30:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:30:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:30:13 INFO - 'HOME': '/Users/cltbld', 19:30:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:30:13 INFO - 'LOGNAME': 'cltbld', 19:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:13 INFO - 'MOZ_NO_REMOTE': '1', 19:30:13 INFO - 'NO_EM_RESTART': '1', 19:30:13 INFO - 'PAGER': '/bin/cat', 19:30:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:13 INFO - 'PWD': '/builds/slave/test', 19:30:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:30:13 INFO - 'SHELL': '/bin/bash', 19:30:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2RyMVOFSr/Listeners', 19:30:13 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:30:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:30:13 INFO - 'USER': 'cltbld', 19:30:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:30:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:13 INFO - 'XPC_FLAGS': '0x0', 19:30:13 INFO - 'XPC_SERVICE_NAME': '0', 19:30:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:13 INFO - Downloading/unpacking flake8 19:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:30:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:30:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:30:17 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 19:30:17 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 19:30:17 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 19:30:17 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 19:30:17 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 19:30:17 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 19:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:30:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:30:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:30:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:30:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:30:17 INFO - no previously-included directories found matching 'docs/_build' 19:30:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:30:17 INFO - Running setup.py install for pep8 19:30:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:30:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:30:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:30:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:30:17 INFO - no previously-included directories found matching 'docs/_build' 19:30:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:30:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:30:17 INFO - Cleaning up... 19:30:17 INFO - Return code: 0 19:30:17 INFO - Running post-action listener: _resource_record_post_action 19:30:17 INFO - Running post-action listener: _start_resource_monitoring 19:30:17 INFO - Starting resource monitoring. 19:30:17 INFO - ##### 19:30:17 INFO - ##### Running install step. 19:30:17 INFO - ##### 19:30:17 INFO - Running pre-action listener: _resource_record_pre_action 19:30:17 INFO - Running main action method: install 19:30:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:30:18 INFO - Reading from file tmpfile_stdout 19:30:18 INFO - Detecting whether we're running mozinstall >=1.0... 19:30:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:30:18 INFO - Reading from file tmpfile_stdout 19:30:18 INFO - Output received: 19:30:18 INFO - Usage: mozinstall [options] installer 19:30:18 INFO - Options: 19:30:18 INFO - -h, --help show this help message and exit 19:30:18 INFO - -d DEST, --destination=DEST 19:30:18 INFO - Directory to install application into. [default: 19:30:18 INFO - "/builds/slave/test"] 19:30:18 INFO - --app=APP Application being installed. [default: firefox] 19:30:18 INFO - mkdir: /builds/slave/test/build/application 19:30:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:30:52 INFO - Reading from file tmpfile_stdout 19:30:52 INFO - Output received: 19:30:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:30:52 INFO - Running post-action listener: _resource_record_post_action 19:30:52 INFO - ##### 19:30:52 INFO - ##### Running run-tests step. 19:30:52 INFO - ##### 19:30:52 INFO - Running pre-action listener: _resource_record_pre_action 19:30:52 INFO - Running main action method: run_tests 19:30:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:30:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:30:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:30:52 INFO - 2016-03-21 19:30:52.415 screenresolution[1640:7337] starting screenresolution argv=screenresolution get 19:30:52 INFO - 2016-03-21 19:30:52.418 screenresolution[1640:7337] Display 0: 1600x1200x32@60 19:30:52 INFO - 2016-03-21 19:30:52.424 screenresolution[1641:7339] starting screenresolution argv=screenresolution list 19:30:52 INFO - Available Modes on Display 0 19:30:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:30:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:30:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:30:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:30:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:30:52 INFO - Intel Iris: 19:30:52 INFO - Chipset Model: Intel Iris 19:30:52 INFO - Type: GPU 19:30:52 INFO - Bus: Built-In 19:30:52 INFO - VRAM (Dynamic, Max): 1536 MB 19:30:52 INFO - Vendor: Intel (0x8086) 19:30:52 INFO - Device ID: 0x0a2e 19:30:52 INFO - Revision ID: 0x0009 19:30:52 INFO - Displays: 19:30:52 INFO - Display: 19:30:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:30:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:30:52 INFO - Display Serial Number: 1600x1200 60 19:30:52 INFO - Main Display: Yes 19:30:52 INFO - Mirror: Off 19:30:52 INFO - Online: Yes 19:30:52 INFO - Rotation: Supported 19:30:52 INFO - Return code: 0 19:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:30:52 INFO - Python 2.7.3 19:30:52 INFO - Return code: 0 19:30:52 INFO - grabbing minidump binary from tooltool 19:30: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')]} 19:30:52 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 0x10b141e00>, '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 0x10afaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b13cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:30:52 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 19:30:52 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 19:30:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:30:52 INFO - Return code: 0 19:30:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:30:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:30:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:30:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:30:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:30:53 INFO - Return code: 0 19:30:53 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/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0142', '--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 19:30:53 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/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0142 --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 19:30:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kpE5WmieyZ/Render', 19:30:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:30:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:30:53 INFO - 'HOME': '/Users/cltbld', 19:30:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:30:53 INFO - 'LOGNAME': 'cltbld', 19:30:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:30:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:53 INFO - 'MOZ_NO_REMOTE': '1', 19:30:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:30:53 INFO - 'NO_EM_RESTART': '1', 19:30:53 INFO - 'PAGER': '/bin/cat', 19:30:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:53 INFO - 'PWD': '/builds/slave/test', 19:30:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:30:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:30:53 INFO - 'SHELL': '/bin/bash', 19:30:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2RyMVOFSr/Listeners', 19:30:53 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:30:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:30:53 INFO - 'USER': 'cltbld', 19:30:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:30:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:53 INFO - 'XPC_FLAGS': '0x0', 19:30:53 INFO - 'XPC_SERVICE_NAME': '0', 19:30:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:30:53 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/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0142', '--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 19:30:54 INFO - mozversion application_buildid: 20160321172928 19:30:54 INFO - mozversion application_changeset: 98189434eea16c181df0c7e8d60af76feceaf492 19:30:54 INFO - mozversion application_display_name: Nightly 19:30:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:30:54 INFO - mozversion application_name: Firefox 19:30:54 INFO - mozversion application_remotingname: firefox 19:30:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:30:54 INFO - mozversion application_vendor: Mozilla 19:30:54 INFO - mozversion application_version: 48.0a1 19:30:54 INFO - mozversion platform_buildid: 20160321172928 19:30:54 INFO - mozversion platform_changeset: 98189434eea16c181df0c7e8d60af76feceaf492 19:30:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:30:54 INFO - mozversion platform_version: 48.0a1 19:30:54 INFO - using testdate: 1458613854 19:30:54 INFO - actual date: 1458613854 19:30:54 INFO - starting webserver on 'localhost:49271' 19:30:54 INFO - SUITE-START | Running 2 tests 19:30:54 INFO - TEST-START | dromaeo_css 19:30:54 INFO - operating with platform_type : mac_ 19:30:54 INFO - Initialising browser for dromaeo_css test... 19:30:54 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmpTpqL0T/profile http://localhost:49271/getInfo.html) 19:30:56 INFO - PROCESS | 1659 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 19:30:57 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 19:30:57 INFO - PROCESS | 1659 | colorDepth:24 19:30:57 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 19:30:57 INFO - PROCESS | 1659 | __metrics 19:30:57 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 19:30:58 INFO - TEST-INFO | 1659: exit 0 19:30:58 INFO - Browser initialized. 19:30:58 INFO - Running cycle 1/1 for dromaeo_css test... 19:30:58 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmpTpqL0T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:10 INFO - PROCESS | 1663 | RSS: Main: 257757184 19:31:10 INFO - PROCESS | 1663 | 19:31:59 INFO - PROCESS | 1663 | 1458613919789 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] 19:34:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 19:34:13 INFO - PROCESS | 1663 | RSS: Main: 269955072 19:34:13 INFO - PROCESS | 1663 | 19:37:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 19:37:15 INFO - PROCESS | 1663 | RSS: Main: 281489408 19:37:15 INFO - PROCESS | 1663 | 19:40:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 19:40:17 INFO - PROCESS | 1663 | RSS: Main: 283471872 19:40:17 INFO - PROCESS | 1663 | 19:43:19 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 19:43:20 INFO - PROCESS | 1663 | RSS: Main: 283713536 19:43:20 INFO - PROCESS | 1663 | 19:46:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 19:46:23 INFO - PROCESS | 1663 | RSS: Main: 286748672 19:46:23 INFO - PROCESS | 1663 | 19:49:25 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 19:49:26 INFO - PROCESS | 1663 | RSS: Main: 289140736 19:49:26 INFO - PROCESS | 1663 | 19:49:26 INFO - PROCESS | 1663 | __start_tp_report 19:49:26 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 19:49:26 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 19:49:26 INFO - PROCESS | 1663 | |i|pagename|runs| 19:49:26 INFO - PROCESS | 1663 | |0;dojo.html;3506.281212351468;3529.9117522061947;3563.9287214255714;3576.9105772355706;3619.348517266891;5726.380909419877;5776.075827867542;5793.594448388604;5830.979578573749;5847.5614328925285;5697.743601537931;5842.357340692521;5902;5975.133605627181;6056.545759068065;5216.504432078956;5273;5297.947020529784;5315.734213289339;5400.864978375533;4364.803583838735;5325.4142044375085;5355;5376.166694162411;5377.65045272058;5220.295260139889;5261.1319132343115;5264.52619264268;5287.68273903567;5333.093374126408;5266.815661451869;5284.894302113975;5291.788328466857;5313.468653134694;5365.3293338332705;4302.913941721179;5227.764750586232;5248.186531087687;5271.683698978035;5280.260763493114;5567.248421463091;5796.420357964212;5844.912326315109;5849.883002339972;5878.147668588031;6198.194234749499;6209.5342849286035;6213.409726076061;6235.594686345373;6236.158118653969;5567.081431563787;5577.776888924438;6165.845853853644;6292.33930437302;6299.826559836849;5523.171524271352;5975.52195824333;5980.581359304807;6001.819945401645;6006.279246490449;5991.850203744942;6069.575129740876;6325.715342809584;6331.936680633226;6344.270408902943;6120.965252118766;6140.473573783631;6204.472619827275;6215.875682486325;6311.368863113652;6154.79981403622;6177.69111544421;6205.348438413992;6208.348123447064;6259.499240060784;6181.258249010058;6231.75072997075;6239;6257.812265632038;6281.277653069864;6157.568970172135;6171.13604095427;6176;6207.968960155261;6262.405071518198;4574.748388838646;4664.787155339568;5034.370703662043;5053.191489361684;5071.492850714899;4479.484859241164;4489.977550112294;4523.751193684379;4524.276115821453;4540.364348991144;5848.619839710405;5872.29532456108;5956.7319470623925;6029.547783916224;6053.51571874249;6227.906581401283;6261.966775482086;6265.780697675559;6274.498040156776;6279.748810047547;5881.911771323434;6018;6020.307664618537;6030.006199628022;6082.148499210114;5463.48096930791;5485.122380419114;5494.780208791683;5517.503424691797;5543.113101903676;6428.517861160338;6435.324290949477;6440.4847612190915;6449.355064493513;6454.5159113065765;6116.082587611716;6212.968935155295;6237.656928868956;6238.937610623836;6242.937570624235;6445.677716114269;6470.644114573555;6500.5449618526245;6502.089707440868;6529.020646903003;6226.62640241587;6232.626042437469;6234.189555357774;6250.937490625218;6259.718312675849;5679.233303503974;6156.230471191101;6184.845378865564;6278.215223097113;6279.748810047547;5526.58550608714;6093.2078829751845;6137.048757442603;6147.938520614915;6157.168782214344;6190.380961903774;6208.192934918612;6229.0967809668255;6233.470155036873;6241.812745617639;5857.121431785266;6103;6109.1141784440115;6113.354685976905;6165.352637972948;6211.565190436807;6215.347388524321;6217.626942383471;6225.533085018732;6227.657478838707;6139.723712432862;6140.3245642978345;6159.014557670751;6182.350853160354;6188.597741146811 19:49:26 INFO - PROCESS | 1663 | |1;ext.html;415.68615695150174;489.27342895799734;500.0548962460948;554.7004617506545;592.9792457263997;36713.81643091784;37272;37296.254074918485;37413.438798418014;37443.25113497728;38324.04189895247;38369;38479;39008.414873776914;39107.41338879919;9247.49138797366;9424.434533927952;9474.47890366033;9512.524373781318;9533.380330278509;9260;9510.144087032166;9513.001134880842;9557.996410376914;9588.904110958905;8264.917350826505;9510.144087032166;9558.80882382352;9642.421454712705;9665.855012174823;9453.952730236339;9534.380265282734;9536.904630953672;9553.283503737213;9555.474448905308;9442.763930901714;9555.522223888778;9574.186194173504;9590.897046839633;9606.039396060409;37499.875003749934;37762.811185943894;37881.81059094687;37903.81048094769;37918.672846450245;3200.7919485233383;3218.4689526228144;3256.6254880688552;3441.4665726812386;3653.2328211075705;28213.576796348072;28257.85871070652;28479.57280640792;28523.714762852313;28594.714052859414;2689.865506724656;2706.742859428351;2752.229375774786;2851.472477591652;2935.2074939766358;489378;491197;492829;496389.51805241103;496764;67435.3256467429;67968.6601566989;68050.65974670195;68065.65967170133;68250;70359;70888;71388.28611713817;71551.64224178846;71677.28322716811;16039.599010024842;16491.09298988567;16491.928024678356;16540.503784886474;16785.748213776802;12723.55467558631;12743.235405875677;12805.231686098863;12829.486820527261;12851.16467429614;18059.729104063448;19239.711404328948;19511.609767804566;20239.886806225506;21686.34940951774;8121;9521.476318802532;9690.12788849007;9714.514274286399;9719.65981190655;949.4588084791602;977.9022097790164;998.256299057207;1001.0690058245756;1002.1882275356838;29655.110346689635;30061.849690751405;30254.84872575623;30701;30959;1031.8091153136693;1096.703889949709;1109.4563663804677;1109.6615532262576;1182.6511179202157;12377.62867113988;12573.55404128537;14274.85725142756;14304.28478576067;14406.711865762625;638311;641277;650550;656311;657196;47658.285125723145;56546.43453565494;56752;56941.86116277651;57093;1341.4298922957703;1379.951701690456;1380.2960490150297;1382.6059573021641;1397.0220845408053;27475.725242747318;27729;28049.01828435995;28083;28220.576691349237;47116;47150.585482435585;47686.28470573013;47735.04529909452;47859.803504912656;493759;496933;500278;500588.99411006883;503104;25896.611550826376;31657.525137122502;32124.03627891167;32232.19419514531;32827.835860820545;42759.57240427556;42848;43219;43694.34458483189;44094.77952610217;35408.82295588506;35867.82066089653;35929;36420.27159456743;36701;35242.82378588091;35398.469022964164;35782;36025.63974360223;36102;33770.49344259887;34622.65377346295;34810.65189348074;35089;35434.822825885705;30925;31770.841145794122;31940.5208921871;32098.51852222172;32107.357852842346;19509.60980780405;23508.52982940366;23674.52650947006;24041.51916961616;24049.639255411534 19:49:26 INFO - PROCESS | 1663 | |2;jquery.html;358.7919006975953;362.2067671798761;369.538077403246;375.1652573025018;375.97932113733737;19423.320183793552;19496.51258718531;20129.899350503227;20131.597368052648;20179.495512612193;11727.589534366278;11973.820392694117;12111.818322725145;12119.33343666098;12137.39313034347;5101.617378696604;5339.70631615261;5612.512684138706;6062.424069713392;6069.1199776032445;5856.912146317809;5955.464008239258;5974.6713930733795;5981.671008094553;5985.16207730918;4817.759112044401;5017.824376146836;5825.359210486843;5833.358330583633;5897.085951677497;5675.858103547403;5713.914356272295;5736.598438109355;5743.5118014968775;6083.8174854754425;5717.171010203498;5735.225744524478;5739.16782066598;5766.279215098113;5773.971130144322;13598.524051658243;13614.455421783117;20942.685859712117;25676.972921083136;25756.87121564399;2005.6189324028535;2035.7048228006856;2091.5150243327257;2238.9776102238934;2515.8490490570625;9950.104490595808;10587.311824731445;11085.833712494239;12465.065120115936;14679.339429725687;1762.5681707981498;1768.5313391951142;1788.2131861980688;1793.2378739035858;1822.7265910113456;68068.6596567019;89279.55360223158;93250.06749932481;105772.94227057784;112058;10968.396738179477;11117.610883619034;11150.944245278723;11224.66326010221;11408;13495.392707328194;13498.325083745773;13512.729745405037;13526;13532.797008044887;8398;8422;8550.657973681107;8593.828123437495;8604.956975215084;8575.656973720981;8737.825243495094;8743.650253989896;8744.300455963508;8844.071372505794;4472.418585583853;4525.343825145335;4528.366028755977;4576.107659006462;4576.839810606612;1893.583411649435;1922.8173323534243;1940.427573865713;1964.9705254421194;1965.5282732144183;927.6845872403416;1035.6064695415694;1052.1530168214508;1078.164422572497;1093.9224863509437;20197.596048078954;20652.79347206509;20876.895615521826;20941.057652405678;21520;848.1010129263001;924.9768755781025;985.0641890204334;1026.9024442677933;1043.4574021508772;8197.4671646344;10007.749806254757;11040.668779936615;11093.944530277297;11142.164337674545;547265;612576;613492;624805;624957.875210621;121637;122774;125990.37004814917;126427;127021;1039.142707266493;1118.899299063072;1120.1430905357408;1171.4377098992532;1175.735459521601;17964.371247006293;18240;18424.907875460536;19113.808861911202;19155.71266430977;49854;49913.75043124761;50245.74877125737;51686.74156629193;52553.68615784636;62442.438939026884;70845.58308833692;72587.91118133126;72791;73074.63462682652;7236.34872861445;7898.960505197438;7958.164392738679;7978.481398709066;8095.7166499172245;9276.95361523215;12304.569340073054;12497.312647804458;12709.237445752915;12802.935985320013;10672.199585031309;10949;11276.379799111128;11333.206675532963;11355.829662554903;9746.658866939622;10726.946365268124;11075.280106793032;11293.887061129284;11303.321800691985;11195.048420884315;11224.775504490028;11330.98021178098;11525;11602.013828824645;7842.64708088126;7897.091834439113;7908.6045697713735;7976.6410511525955;8055.879161812694;10135.543900524346;11010.724731881766;11446.198766086294;11474.713132171762;11495.597654082401 19:49:26 INFO - PROCESS | 1663 | |3;mootools.html;1611.6696077304152;1634.1339090282152;1930.5270208798838;1992.6712092504738;2005.8696184747998;6763.42510886574;8039.91960080399;8809.38334316598;9000.549972501381;9033.05152958939;8712.215900568948;8749.387542872002;8825.293976481882;8844.646214151426;8870.112988701143;2051.835853131746;2068.3794861541514;2484.043643197364;2492.2149522900318;2501.024600405843;2464.556379851626;2487.639292302615;2493.4389762303426;2501.487195124995;2511.2842839790665;2137.5724855029057;2482.7889629381525;2487.45276039272;2518.244526642009;2527.835690680109;2479.194261864901;2486.7388924162974;2499.6500489931423;2513.5978243481045;2513.9748602513923;2126.574685062978;2470.147799009339;2505.185814610259;2506.862122583257;2523.1673547729206;8869.423487473357;8919.554022298858;8919.554022298924;8928.821423571557;8959.372843900865;5469.124940009579;5546.362168350651;5592.552595792326;5606.383297837235;5610.551155907518;3586.067622418164;3715.3498137825773;3720.9953312605717;3733.8693145739767;3738.9626103738888;1032.5147180825;1063.595833583241;1065.222387657007;1075.6826736112866;1078;11913.046956243566;11988.400579971054;12038.81941770874;12065.939670301592;12082.395880205955;4862.076205521011;4891.486393928586;4994.750262486861;5004.499550044967;5017.247412888096;10091.49542522871;10135.543900524493;10142.391456512632;10144.492775361203;10148.695539133838;5577.860553486114;5579.302587176603;5582.63712858671;5590.18942253371;5594.776208951678;4480.215962206601;4859.635527335393;5026.572741317029;5048.419431765321;5089.821856235014;3920.2355540669296;3963.425303331001;3983.2830090583975;4008.2785098681934;4021.7586944783407;1292.4959265886312;1344.0658742174292;1347.7169794343297;1348.575198812371;1355.0311527257861;1139.7606502634374;1311.967200819968;1376.256821316478;1396.6717821311984;1407.4440595964536;8145.933489610277;8152.714654987047;8228;8228.259456648811;8244.464109832841;520.0301437818517;527.7150338816996;528.3897098850833;528.9788408463695;530.2179285553855;6104.664243466563;6175.413335733098;6277.843053923597;6329.9872020476505;6372.7132279047555;10394.22043346752;10789.082927951213;10808.78382432347;10837.566497340018;10863.402512861869;10540.841887371696;10636.840447393295;10688.412137332365;10723.14214862809;10773.676789696321;7172.318629730167;8330.083690794008;8409.83180336402;8477.321814254845;8511.97856257253;7812.296893279632;7841.019872515935;7909.485883417559;7917.406194535318;7939.523628582304;9334.533273336441;9598.89612694549;9709.951450242703;9716.514174291116;9730.978247283932;9765.21878249724;9852.950735246279;10068.89931100709;10085.899141008496;10160.644377446753;5710.371859095413;6301;6567.507436942344;7181.138263408425;7432;7140.8214794628475;8120.796980075545;8142.877856832034;8208.425410221227;8236.382271329554;6435;7262.89105663426;7329.193788683134;7387.556746595222;7496.362809161064;7235.602041887747;7238.6380680966795;7278.199398066103;7331;7397.334239918433;7752.92247077522;7770.650320735467;7788.376929845712;7844.254795794391;7850.0972388173805;7015.36861682451;7065.576065435885;7070.964645176741;7075.858482830417;7085.14978202619;6890.276520965427;7110.715571377087;7115;7118.644067796693;7144.607046612487 19:49:26 INFO - PROCESS | 1663 | |4;prototype.html;331.64348325550037;332.7304883044734;336.76763033506893;336.9258763072124;344.05899863872304;7010.123734533184;7025.402840758542;7088.893666594992;7093.822654433642;7097.964510177449;6997.720091196346;7009.264027277126;7018.298170182979;7022.262662420449;7053.294670532944;4251.404803327537;4869.732164730938;5080.339555857733;5099.796008159669;5143.562797162245;5049.77276022578;5055.51972562606;5082.390113186404;5084.084864724348;5088.23676448532;5007.7496125193775;5014.473480284572;5038.798448062092;5050.747462626872;5058.165402708549;5013;5068.72122033288;5116.283720279164;5119.513646203642;5132.28148059272;4363.716358436692;4365.847195348148;4371.388005679208;4373.584509471595;4387.802548885308;6532.611924670866;6574.342565743435;6698.755916767888;6728.899066514006;6754.493412993996;5931.317898441691;5980.820575382745;5991.850203744898;6000;6008.158857759917;7395.778126656209;7400.259974002557;7414.221506741768;7427.888581671279;7427.994441500765;3994.121293315466;4864.610831133501;4873.658843880929;4881.096997055556;4895.437024742165;7621.580813055224;7901.38021705549;7904.051513818321;7911.881321780178;7952.840943181104;4432.711873728197;4731.361266229015;4956.405231372259;4986.376702912136;5011.198208286657;4112.177564487115;4678.713353827725;5098.1842905135;5112.386513618315;5113.590912726973;5926.733297001645;5957.106434034929;5962.582619216613;5970.194023806817;5983.222181116514;7455.925440745632;7486.213947535539;7490.812729681802;7490.85018299631;7530.096388433423;1758.0067261997187;1782.3049010885766;1785.9374921877672;1787.9553011174564;1789.6152327249442;1045.9058684718411;1089.7929393415225;1091.170710260208;1097.8243481042996;1099.2195541165702;5781.595288329777;6200.844978875474;6585.715785421797;6979.4765392594745;7050.506464547432;6502.7724029659685;7714.691412343555;7722.498037627536;7731.536107833435;7756.922430775733;6539.574927629689;7074.7170113195925;7121.9643901780155;7125.786226413215;7154.606496642735;3389.81356025416;4108.815103320358;4129.339305711072;4144.544100148981;4162.4796900387455;6656.866862662817;8227.42408031444;8228.382871284677;8236.958815206006;8263.917360826435;7759.418043646636;8106.594670266463;8107.067687215927;8130.634121464548;8156.714514992065;8129.5122292661445;8194.836103277901;8201.917980820235;8208.507489550646;8216.46592971455;7812.84374312522;7818.866264391745;7820.530768153929;7837.725679601187;7841.686332546634;6160.476359509313;7658.617069146632;7686.3082322591235;7688.46180767341;7702.961485192538;7925.445218834626;8195.795105122419;8219.301359384519;8220.876686849582;8242.958785206036;4045.575214602542;4783.497732738151;4786.712797232177;4819.7108173509705;4823.831165909176;7762.650680719268;7789.376849852111;7804.648790804541;7809.297163255334;7831.686732530635;5962.449763061549;7513.323800857949;7530.623468826647;7545.773626791205;7567.432442566939;7174.210836808052;7527.924720752722;7530.623468826647;7548.698052077855;7564.092308922965;7313.414926805949;7341.229170936975;7343.265673432614;7353.852922941404;7375.151857536452;7509.6245187739305;7511.624418779148;7513.661885215288;7531.774046778605;7538.246175382418;7120.359167674934;7342.6695798688115;7352.669129889061;7389.667464964197;7393.778186654409 19:49:26 INFO - PROCESS | 1663 | |5;yui.html;632.9145565348676;637.3371693438824;660.385841167714;680.6494655252549;712.5688958180301;13839.999999999975;14205.289735513235;15050.548483545484;15416.152111633855;15426.768598471019;15717.921410392932;15807.683846323067;15873.92063039686;15900.52298431049;15913.840861591381;739.7854622159581;919.2829592917502;933.351320832022;936.2276122199179;936.4381371177308;919.6781126605667;924.8427767279545;930.5300823084333;930.7626555228408;933.2673851026946;972.65470757881;973.6154219083458;982.287841315048;985.5121714751173;986.8371718666411;947.4788866123639;973.459729849933;973.6202880876464;976.9071938165933;977.1791694976218;563.3802816901417;588.9676067816268;717.0892965933288;727.923568025355;728.420905380224;15100;15351.232438378149;15519.5344139676;15737.213139343101;15761.684766304725;11491.94254028733;12263.632091037283;12352.320622365767;12359.25844449336;12436.689082772913;9827.656032038843;9910.35582687123;9959.701208963743;10161.441120738356;10191.745206369826;3387.5088112223834;3423.9828800855835;3430.142464383904;3473.7394695397948;3490.336836001152;76100.61949690216;78065.60967195184;78764.21235787684;81266.59366703128;82571.58714206451;9587.18508926735;9605;9646.987066357931;9886.950565247127;9892.80214395708;21319.78680213209;21345.78654213438;21354.039068241967;21365.78634213669;21404.25085122013;7566.35685966699;7686.077670679442;7688.269614386624;7769.572673502898;7880.921190788134;4119.608637179464;4178.12259425518;4187.43469631602;4197.790110494524;4198.5591512891315;3651.634836516327;3695.0392897846214;3704;3708.49935258742;3710.5547334319513;655.4592461219513;657.746767494518;658.4370363339372;661.9073329733841;664.6145235763246;540.9756560954767;572.0732413490173;591.1477122882026;599.5203836930439;607.3016031563737;8259.752207433787;8277.04813946404;8316.459430137022;8416.957915210385;8513.233808957224;565.547561950438;599.0206013168414;605.1572960335789;610.081826850587;611.8348046027547;3694.8152592370275;3870.8838734837436;3922.7057970651745;3973.1457736586194;4048.438622124231;73490.632546838;91768.0823191773;93968;94430;94544;76203.61898190473;78571.60714196392;80635;80745.59627201826;81014.59492702616;65522;70634;73565;73777.26222737812;75529;8507.276881465144;8552.743417697478;8553.61508732096;8645.740627781177;8678.913210868062;44321.99999999871;49345.259821101994;50728;51200.719982000744;51705.482945170064;62463.37536624575;68346;68764.6561767188;68856.311436887;69262.65368673124;10855.422468757359;10872.945635271773;10984.505697243483;11262.605808796981;11401.087912966777;11882.346470944181;11988.940055299669;12025.63923082309;12188.878111218773;12198.390080495763;11304.717382065513;11384.943075284571;11407.600733974272;11462.484188211383;11629;11348.489317980546;11564.363959982282;11602.060990953303;11735.002524785148;12437.813432798695;11017.283876548;11384.54461821551;11616.012638925786;11623.12826537996;12196.329201893981;8894.066123056986;9261.490618016074;9527.809443811224;9729.173020293354;9859.852102218616;8453.746387608382;8652;8879.91120088791;9305.395149315273;9511.904880951102 19:49:26 INFO - PROCESS | 1663 | __end_tp_report 19:49:26 INFO - PROCESS | 1663 | __start_cc_report 19:49:26 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,383 19:49:26 INFO - PROCESS | 1663 | __end_cc_report 19:49:26 INFO - PROCESS | 1663 | __startTimestamp1458614966188__endTimestamp 19:49:26 INFO - PROCESS | 1663 | 19:49:26 INFO - PROCESS | 1663 | ------- Summary: start ------- 19:49:26 INFO - PROCESS | 1663 | Number of tests: 6 19:49:26 INFO - PROCESS | 1663 | 19:49:26 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5805.38 Median:6093.21 stddev:637.66 (10.5%) stddev-sans-first:613.58 19:49:26 INFO - PROCESS | 1663 | Values: 3506.3 3529.9 3563.9 3576.9 3619.3 5726.4 5776.1 5793.6 5831.0 5847.6 5697.7 5842.4 5902.0 5975.1 6056.5 5216.5 5273.0 5297.9 5315.7 5400.9 4364.8 5325.4 5355.0 5376.2 5377.7 5220.3 5261.1 5264.5 5287.7 5333.1 5266.8 5284.9 5291.8 5313.5 5365.3 4302.9 5227.8 5248.2 5271.7 5280.3 5567.2 5796.4 5844.9 5849.9 5878.1 6198.2 6209.5 6213.4 6235.6 6236.2 5567.1 5577.8 6165.8 6292.3 6299.8 5523.2 5975.5 5980.6 6001.8 6006.3 5991.9 6069.6 6325.7 6331.9 6344.3 6121.0 6140.5 6204.5 6215.9 6311.4 6154.8 6177.7 6205.3 6208.3 6259.5 6181.3 6231.8 6239.0 6257.8 6281.3 6157.6 6171.1 6176.0 6208.0 6262.4 4574.7 4664.8 5034.4 5053.2 5071.5 4479.5 4490.0 4523.8 4524.3 4540.4 5848.6 5872.3 5956.7 6029.5 6053.5 6227.9 6262.0 6265.8 6274.5 6279.7 5881.9 6018.0 6020.3 6030.0 6082.1 5463.5 5485.1 5494.8 5517.5 5543.1 6428.5 6435.3 6440.5 6449.4 6454.5 6116.1 6213.0 6237.7 6238.9 6242.9 6445.7 6470.6 6500.5 6502.1 6529.0 6226.6 6232.6 6234.2 6250.9 6259.7 5679.2 6156.2 6184.8 6278.2 6279.7 5526.6 6093.2 6137.0 6147.9 6157.2 6190.4 6208.2 6229.1 6233.5 6241.8 5857.1 6103.0 6109.1 6113.4 6165.4 6211.6 6215.3 6217.6 6225.5 6227.7 6139.7 6140.3 6159.0 6182.4 6188.6 19:49:26 INFO - PROCESS | 1663 | 19:49:26 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:67996.04 Median:37428.34 stddev:147445.99 (393.9%) stddev-sans-first:147772.31 19:49:26 INFO - PROCESS | 1663 | Values: 415.7 489.3 500.1 554.7 593.0 36713.8 37272.0 37296.3 37413.4 37443.3 38324.0 38369.0 38479.0 39008.4 39107.4 9247.5 9424.4 9474.5 9512.5 9533.4 9260.0 9510.1 9513.0 9558.0 9588.9 8264.9 9510.1 9558.8 9642.4 9665.9 9454.0 9534.4 9536.9 9553.3 9555.5 9442.8 9555.5 9574.2 9590.9 9606.0 37499.9 37762.8 37881.8 37903.8 37918.7 3200.8 3218.5 3256.6 3441.5 3653.2 28213.6 28257.9 28479.6 28523.7 28594.7 2689.9 2706.7 2752.2 2851.5 2935.2 489378.0 491197.0 492829.0 496389.5 496764.0 67435.3 67968.7 68050.7 68065.7 68250.0 70359.0 70888.0 71388.3 71551.6 71677.3 16039.6 16491.1 16491.9 16540.5 16785.7 12723.6 12743.2 12805.2 12829.5 12851.2 18059.7 19239.7 19511.6 20239.9 21686.3 8121.0 9521.5 9690.1 9714.5 9719.7 949.5 977.9 998.3 1001.1 1002.2 29655.1 30061.8 30254.8 30701.0 30959.0 1031.8 1096.7 1109.5 1109.7 1182.7 12377.6 12573.6 14274.9 14304.3 14406.7 638311.0 641277.0 650550.0 656311.0 657196.0 47658.3 56546.4 56752.0 56941.9 57093.0 1341.4 1380.0 1380.3 1382.6 1397.0 27475.7 27729.0 28049.0 28083.0 28220.6 47116.0 47150.6 47686.3 47735.0 47859.8 493759.0 496933.0 500278.0 500589.0 503104.0 25896.6 31657.5 32124.0 32232.2 32827.8 42759.6 42848.0 43219.0 43694.3 44094.8 35408.8 35867.8 35929.0 36420.3 36701.0 35242.8 35398.5 35782.0 36025.6 36102.0 33770.5 34622.7 34810.7 35089.0 35434.8 30925.0 31770.8 31940.5 32098.5 32107.4 19509.6 23508.5 23674.5 24041.5 24049.6 19:49:26 INFO - PROCESS | 1663 | 19:49:26 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:33725.99 Median:11484.21 stddev:100419.88 (874.4%) stddev-sans-first:100670.33 19:49:26 INFO - PROCESS | 1663 | Values: 358.8 362.2 369.5 375.2 376.0 19423.3 19496.5 20129.9 20131.6 20179.5 11727.6 11973.8 12111.8 12119.3 12137.4 5101.6 5339.7 5612.5 6062.4 6069.1 5856.9 5955.5 5974.7 5981.7 5985.2 4817.8 5017.8 5825.4 5833.4 5897.1 5675.9 5713.9 5736.6 5743.5 6083.8 5717.2 5735.2 5739.2 5766.3 5774.0 13598.5 13614.5 20942.7 25677.0 25756.9 2005.6 2035.7 2091.5 2239.0 2515.8 9950.1 10587.3 11085.8 12465.1 14679.3 1762.6 1768.5 1788.2 1793.2 1822.7 68068.7 89279.6 93250.1 105772.9 112058.0 10968.4 11117.6 11150.9 11224.7 11408.0 13495.4 13498.3 13512.7 13526.0 13532.8 8398.0 8422.0 8550.7 8593.8 8605.0 8575.7 8737.8 8743.7 8744.3 8844.1 4472.4 4525.3 4528.4 4576.1 4576.8 1893.6 1922.8 1940.4 1965.0 1965.5 927.7 1035.6 1052.2 1078.2 1093.9 20197.6 20652.8 20876.9 20941.1 21520.0 848.1 925.0 985.1 1026.9 1043.5 8197.5 10007.7 11040.7 11093.9 11142.2 547265.0 612576.0 613492.0 624805.0 624957.9 121637.0 122774.0 125990.4 126427.0 127021.0 1039.1 1118.9 1120.1 1171.4 1175.7 17964.4 18240.0 18424.9 19113.8 19155.7 49854.0 49913.8 50245.7 51686.7 52553.7 62442.4 70845.6 72587.9 72791.0 73074.6 7236.3 7899.0 7958.2 7978.5 8095.7 9277.0 12304.6 12497.3 12709.2 12802.9 10672.2 10949.0 11276.4 11333.2 11355.8 9746.7 10726.9 11075.3 11293.9 11303.3 11195.0 11224.8 11331.0 11525.0 11602.0 7842.6 7897.1 7908.6 7976.6 8055.9 10135.5 11010.7 11446.2 11474.7 11495.6 19:49:26 INFO - PROCESS | 1663 | 19:49:26 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6047.14 Median:528.68 stddev:3203.12 (605.9%) stddev-sans-first:3194.76 19:49:26 INFO - PROCESS | 1663 | Values: 1611.7 1634.1 1930.5 1992.7 2005.9 6763.4 8039.9 8809.4 9000.5 9033.1 8712.2 8749.4 8825.3 8844.6 8870.1 2051.8 2068.4 2484.0 2492.2 2501.0 2464.6 2487.6 2493.4 2501.5 2511.3 2137.6 2482.8 2487.5 2518.2 2527.8 2479.2 2486.7 2499.7 2513.6 2514.0 2126.6 2470.1 2505.2 2506.9 2523.2 8869.4 8919.6 8919.6 8928.8 8959.4 5469.1 5546.4 5592.6 5606.4 5610.6 3586.1 3715.3 3721.0 3733.9 3739.0 1032.5 1063.6 1065.2 1075.7 1078.0 11913.0 11988.4 12038.8 12065.9 12082.4 4862.1 4891.5 4994.8 5004.5 5017.2 10091.5 10135.5 10142.4 10144.5 10148.7 5577.9 5579.3 5582.6 5590.2 5594.8 4480.2 4859.6 5026.6 5048.4 5089.8 3920.2 3963.4 3983.3 4008.3 4021.8 1292.5 1344.1 1347.7 1348.6 1355.0 1139.8 1312.0 1376.3 1396.7 1407.4 8145.9 8152.7 8228.0 8228.3 8244.5 520.0 527.7 528.4 529.0 530.2 6104.7 6175.4 6277.8 6330.0 6372.7 10394.2 10789.1 10808.8 10837.6 10863.4 10540.8 10636.8 10688.4 10723.1 10773.7 7172.3 8330.1 8409.8 8477.3 8512.0 7812.3 7841.0 7909.5 7917.4 7939.5 9334.5 9598.9 9710.0 9716.5 9731.0 9765.2 9853.0 10068.9 10085.9 10160.6 5710.4 6301.0 6567.5 7181.1 7432.0 7140.8 8120.8 8142.9 8208.4 8236.4 6435.0 7262.9 7329.2 7387.6 7496.4 7235.6 7238.6 7278.2 7331.0 7397.3 7752.9 7770.7 7788.4 7844.3 7850.1 7015.4 7065.6 7071.0 7075.9 7085.1 6890.3 7110.7 7115.0 7118.6 7144.6 19:49:26 INFO - PROCESS | 1663 | 19:49:26 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:6091.99 Median:7009.69 stddev:1992.39 (28.4%) stddev-sans-first:1950.50 19:49:26 INFO - PROCESS | 1663 | Values: 331.6 332.7 336.8 336.9 344.1 7010.1 7025.4 7088.9 7093.8 7098.0 6997.7 7009.3 7018.3 7022.3 7053.3 4251.4 4869.7 5080.3 5099.8 5143.6 5049.8 5055.5 5082.4 5084.1 5088.2 5007.7 5014.5 5038.8 5050.7 5058.2 5013.0 5068.7 5116.3 5119.5 5132.3 4363.7 4365.8 4371.4 4373.6 4387.8 6532.6 6574.3 6698.8 6728.9 6754.5 5931.3 5980.8 5991.9 6000.0 6008.2 7395.8 7400.3 7414.2 7427.9 7428.0 3994.1 4864.6 4873.7 4881.1 4895.4 7621.6 7901.4 7904.1 7911.9 7952.8 4432.7 4731.4 4956.4 4986.4 5011.2 4112.2 4678.7 5098.2 5112.4 5113.6 5926.7 5957.1 5962.6 5970.2 5983.2 7455.9 7486.2 7490.8 7490.9 7530.1 1758.0 1782.3 1785.9 1788.0 1789.6 1045.9 1089.8 1091.2 1097.8 1099.2 5781.6 6200.8 6585.7 6979.5 7050.5 6502.8 7714.7 7722.5 7731.5 7756.9 6539.6 7074.7 7122.0 7125.8 7154.6 3389.8 4108.8 4129.3 4144.5 4162.5 6656.9 8227.4 8228.4 8237.0 8263.9 7759.4 8106.6 8107.1 8130.6 8156.7 8129.5 8194.8 8201.9 8208.5 8216.5 7812.8 7818.9 7820.5 7837.7 7841.7 6160.5 7658.6 7686.3 7688.5 7703.0 7925.4 8195.8 8219.3 8220.9 8243.0 4045.6 4783.5 4786.7 4819.7 4823.8 7762.7 7789.4 7804.6 7809.3 7831.7 5962.4 7513.3 7530.6 7545.8 7567.4 7174.2 7527.9 7530.6 7548.7 7564.1 7313.4 7341.2 7343.3 7353.9 7375.2 7509.6 7511.6 7513.7 7531.8 7538.2 7120.4 7342.7 7352.7 7389.7 7393.8 19:49:26 INFO - PROCESS | 1663 | 19:49:26 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18326.01 Median:635.13 stddev:25584.76 (4028.3%) stddev-sans-first:25622.03 19:49:26 INFO - PROCESS | 1663 | Values: 632.9 637.3 660.4 680.6 712.6 13840.0 14205.3 15050.5 15416.2 15426.8 15717.9 15807.7 15873.9 15900.5 15913.8 739.8 919.3 933.4 936.2 936.4 919.7 924.8 930.5 930.8 933.3 972.7 973.6 982.3 985.5 986.8 947.5 973.5 973.6 976.9 977.2 563.4 589.0 717.1 727.9 728.4 15100.0 15351.2 15519.5 15737.2 15761.7 11491.9 12263.6 12352.3 12359.3 12436.7 9827.7 9910.4 9959.7 10161.4 10191.7 3387.5 3424.0 3430.1 3473.7 3490.3 76100.6 78065.6 78764.2 81266.6 82571.6 9587.2 9605.0 9647.0 9887.0 9892.8 21319.8 21345.8 21354.0 21365.8 21404.3 7566.4 7686.1 7688.3 7769.6 7880.9 4119.6 4178.1 4187.4 4197.8 4198.6 3651.6 3695.0 3704.0 3708.5 3710.6 655.5 657.7 658.4 661.9 664.6 541.0 572.1 591.1 599.5 607.3 8259.8 8277.0 8316.5 8417.0 8513.2 565.5 599.0 605.2 610.1 611.8 3694.8 3870.9 3922.7 3973.1 4048.4 73490.6 91768.1 93968.0 94430.0 94544.0 76203.6 78571.6 80635.0 80745.6 81014.6 65522.0 70634.0 73565.0 73777.3 75529.0 8507.3 8552.7 8553.6 8645.7 8678.9 44322.0 49345.3 50728.0 51200.7 51705.5 62463.4 68346.0 68764.7 68856.3 69262.7 10855.4 10872.9 10984.5 11262.6 11401.1 11882.3 11988.9 12025.6 12188.9 12198.4 11304.7 11384.9 11407.6 11462.5 11629.0 11348.5 11564.4 11602.1 11735.0 12437.8 11017.3 11384.5 11616.0 11623.1 12196.3 8894.1 9261.5 9527.8 9729.2 9859.9 8453.7 8652.0 8879.9 9305.4 9511.9 19:49:26 INFO - PROCESS | 1663 | -------- Summary: end -------- 19:49:26 INFO - PROCESS | 1663 | 19:49:26 INFO - TEST-INFO | 1663: exit 0 19:49:26 INFO - TEST-OK | dromaeo_css | took 1112523ms 19:49:26 INFO - TEST-START | kraken 19:49:26 INFO - operating with platform_type : mac_ 19:49:26 INFO - Initialising browser for kraken test... 19:49:26 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmpPGI5pY/profile http://localhost:49271/getInfo.html) 19:49:29 INFO - PROCESS | 1675 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 19:49:29 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 19:49:29 INFO - PROCESS | 1675 | colorDepth:24 19:49:29 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 19:49:29 INFO - PROCESS | 1675 | __metrics 19:49:29 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 19:49:30 INFO - TEST-INFO | 1675: exit 0 19:49:30 INFO - Browser initialized. 19:49:30 INFO - Running cycle 1/1 for kraken test... 19:49:30 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmpPGI5pY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:49:42 INFO - PROCESS | 1678 | RSS: Main: 257327104 19:49:42 INFO - PROCESS | 1678 | 19:49:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 19:49:45 INFO - PROCESS | 1678 | RSS: Main: 267689984 19:49:45 INFO - PROCESS | 1678 | 19:49:48 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 19:49:49 INFO - PROCESS | 1678 | RSS: Main: 277590016 19:49:49 INFO - PROCESS | 1678 | 19:49:52 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 19:49:53 INFO - PROCESS | 1678 | RSS: Main: 280059904 19:49:53 INFO - PROCESS | 1678 | 19:49:54 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 19:49:55 INFO - PROCESS | 1678 | RSS: Main: 280743936 19:49:55 INFO - PROCESS | 1678 | 19:49:57 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:49:58 INFO - PROCESS | 1678 | RSS: Main: 281055232 19:49:58 INFO - PROCESS | 1678 | 19:50:01 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 19:50:01 INFO - PROCESS | 1678 | RSS: Main: 282468352 19:50:01 INFO - PROCESS | 1678 | 19:50:04 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 19:50:05 INFO - PROCESS | 1678 | RSS: Main: 282329088 19:50:05 INFO - PROCESS | 1678 | 19:50:08 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 19:50:09 INFO - PROCESS | 1678 | RSS: Main: 284213248 19:50:09 INFO - PROCESS | 1678 | 19:50:10 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:50:11 INFO - PROCESS | 1678 | RSS: Main: 282898432 19:50:11 INFO - PROCESS | 1678 | 19:50:13 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:50:14 INFO - PROCESS | 1678 | RSS: Main: 283127808 19:50:14 INFO - PROCESS | 1678 | 19:50:16 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:50:16 INFO - PROCESS | 1678 | RSS: Main: 283582464 19:50:16 INFO - PROCESS | 1678 | 19:50:19 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:50:20 INFO - PROCESS | 1678 | RSS: Main: 284647424 19:50:20 INFO - PROCESS | 1678 | 19:50:22 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:50:23 INFO - PROCESS | 1678 | RSS: Main: 282861568 19:50:23 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 19:50:25 INFO - PROCESS | 1678 | RSS: Main: 284598272 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | __start_tp_report 19:50:25 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 19:50:25 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 19:50:25 INFO - PROCESS | 1678 | |i|pagename|runs| 19:50:25 INFO - PROCESS | 1678 | |0;ai-astar;113;106;114;116;111;127;114;113;114;115 19:50:25 INFO - PROCESS | 1678 | |1;audio-beat-detection;162;125;149;156;127;174;169;145;159;125 19:50:25 INFO - PROCESS | 1678 | |2;audio-dft;195;197;201;208;206;257;197;208;201;202 19:50:25 INFO - PROCESS | 1678 | |3;audio-fft;55;57;64;71;66;119;63;78;85;78 19:50:25 INFO - PROCESS | 1678 | |4;audio-oscillator;81;86;119;80;79;89;115;82;79;115 19:50:25 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;93;87;76;114;135;95;91;77;119;132 19:50:25 INFO - PROCESS | 1678 | |6;imaging-darkroom;96;96;151;90;95;95;98;100;153;98 19:50:25 INFO - PROCESS | 1678 | |7;imaging-desaturate;90;131;140;132;133;100;99;147;143;108 19:50:25 INFO - PROCESS | 1678 | |8;json-parse-financial;56;58;57;55;58;59;61;81;89;83 19:50:25 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;68;72;74;92;64;95;103;103;100;85 19:50:25 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;87;100;108;109;109;85;85;84;84;85 19:50:25 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;138;142;118;124;121;121;119;120;135;130 19:50:25 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;140;154;137;141;159;181;181;143;139;141 19:50:25 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;67;68;72;68;94;98;104;75;68;68 19:50:25 INFO - PROCESS | 1678 | __end_tp_report 19:50:25 INFO - PROCESS | 1678 | __start_cc_report 19:50:25 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,963 19:50:25 INFO - PROCESS | 1678 | __end_cc_report 19:50:25 INFO - PROCESS | 1678 | __startTimestamp1458615025320__endTimestamp 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | ------- Summary: start ------- 19:50:25 INFO - PROCESS | 1678 | Number of tests: 14 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.00 stddev:5.25 (4.6%) stddev-sans-first:5.55 19:50:25 INFO - PROCESS | 1678 | Values: 113.0 106.0 114.0 116.0 111.0 127.0 114.0 113.0 114.0 115.0 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:157.50 stddev:18.24 (11.6%) stddev-sans-first:18.74 19:50:25 INFO - PROCESS | 1678 | Values: 162.0 125.0 149.0 156.0 127.0 174.0 169.0 145.0 159.0 125.0 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:207.20 Median:204.00 stddev:18.08 (8.9%) stddev-sans-first:18.64 19:50:25 INFO - PROCESS | 1678 | Values: 195.0 197.0 201.0 208.0 206.0 257.0 197.0 208.0 201.0 202.0 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:73.60 Median:68.50 stddev:18.62 (27.2%) stddev-sans-first:18.49 19:50:25 INFO - PROCESS | 1678 | Values: 55.0 57.0 64.0 71.0 66.0 119.0 63.0 78.0 85.0 78.0 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:80.50 stddev:16.77 (20.8%) stddev-sans-first:17.27 19:50:25 INFO - PROCESS | 1678 | Values: 81.0 86.0 119.0 80.0 79.0 89.0 115.0 82.0 79.0 115.0 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:101.90 Median:82.00 stddev:21.60 (26.3%) stddev-sans-first:22.67 19:50:25 INFO - PROCESS | 1678 | Values: 93.0 87.0 76.0 114.0 135.0 95.0 91.0 77.0 119.0 132.0 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:107.20 Median:95.50 stddev:23.76 (24.9%) stddev-sans-first:24.86 19:50:25 INFO - PROCESS | 1678 | Values: 96.0 96.0 151.0 90.0 95.0 95.0 98.0 100.0 153.0 98.0 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:122.30 Median:141.50 stddev:20.88 (14.8%) stddev-sans-first:18.59 19:50:25 INFO - PROCESS | 1678 | Values: 90.0 131.0 140.0 132.0 133.0 100.0 99.0 147.0 143.0 108.0 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:60.00 stddev:13.11 (21.8%) stddev-sans-first:13.42 19:50:25 INFO - PROCESS | 1678 | Values: 56.0 58.0 57.0 55.0 58.0 59.0 61.0 81.0 89.0 83.0 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:85.60 Median:73.00 stddev:15.05 (20.6%) stddev-sans-first:14.55 19:50:25 INFO - PROCESS | 1678 | Values: 68.0 72.0 74.0 92.0 64.0 95.0 103.0 103.0 100.0 85.0 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:84.50 stddev:11.41 (13.5%) stddev-sans-first:11.85 19:50:25 INFO - PROCESS | 1678 | Values: 87.0 100.0 108.0 109.0 109.0 85.0 85.0 84.0 84.0 85.0 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:127.00 stddev:8.78 (6.9%) stddev-sans-first:8.32 19:50:25 INFO - PROCESS | 1678 | Values: 138.0 142.0 118.0 124.0 121.0 121.0 119.0 120.0 135.0 130.0 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:148.50 stddev:16.98 (11.4%) stddev-sans-first:17.48 19:50:25 INFO - PROCESS | 1678 | Values: 140.0 154.0 137.0 141.0 159.0 181.0 181.0 143.0 139.0 141.0 19:50:25 INFO - PROCESS | 1678 | 19:50:25 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.20 Median:70.00 stddev:14.52 (20.7%) stddev-sans-first:14.82 19:50:25 INFO - PROCESS | 1678 | Values: 67.0 68.0 72.0 68.0 94.0 98.0 104.0 75.0 68.0 68.0 19:50:25 INFO - PROCESS | 1678 | -------- Summary: end -------- 19:50:25 INFO - PROCESS | 1678 | 19:50:26 INFO - TEST-INFO | 1678: exit 0 19:50:26 INFO - TEST-OK | kraken | took 59350ms 19:50:26 INFO - SUITE-END | took 1171s 19:50:26 INFO - Completed test suite (00:19:32) 19:50:26 INFO - javascript benchmark 19:50:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3506.281212351468, 3529.9117522061947, 3563.9287214255714, 3576.9105772355706, 3619.348517266891, 5726.380909419877, 5776.075827867542, 5793.594448388604, 5830.979578573749, 5847.5614328925285, 5697.743601537931, 5842.357340692521, 5902.0, 5975.133605627181, 6056.545759068065, 5216.504432078956, 5273.0, 5297.947020529784, 5315.734213289339, 5400.864978375533, 4364.803583838735, 5325.4142044375085, 5355.0, 5376.166694162411, 5377.65045272058, 5220.295260139889, 5261.1319132343115, 5264.52619264268, 5287.68273903567, 5333.093374126408, 5266.815661451869, 5284.894302113975, 5291.788328466857, 5313.468653134694, 5365.3293338332705, 4302.913941721179, 5227.764750586232, 5248.186531087687, 5271.683698978035, 5280.260763493114, 5567.248421463091, 5796.420357964212, 5844.912326315109, 5849.883002339972, 5878.147668588031, 6198.194234749499, 6209.5342849286035, 6213.409726076061, 6235.594686345373, 6236.158118653969, 5567.081431563787, 5577.776888924438, 6165.845853853644, 6292.33930437302, 6299.826559836849, 5523.171524271352, 5975.52195824333, 5980.581359304807, 6001.819945401645, 6006.279246490449, 5991.850203744942, 6069.575129740876, 6325.715342809584, 6331.936680633226, 6344.270408902943, 6120.965252118766, 6140.473573783631, 6204.472619827275, 6215.875682486325, 6311.368863113652, 6154.79981403622, 6177.69111544421, 6205.348438413992, 6208.348123447064, 6259.499240060784, 6181.258249010058, 6231.75072997075, 6239.0, 6257.812265632038, 6281.277653069864, 6157.568970172135, 6171.13604095427, 6176.0, 6207.968960155261, 6262.405071518198, 4574.748388838646, 4664.787155339568, 5034.370703662043, 5053.191489361684, 5071.492850714899, 4479.484859241164, 4489.977550112294, 4523.751193684379, 4524.276115821453, 4540.364348991144, 5848.619839710405, 5872.29532456108, 5956.7319470623925, 6029.547783916224, 6053.51571874249, 6227.906581401283, 6261.966775482086, 6265.780697675559, 6274.498040156776, 6279.748810047547, 5881.911771323434, 6018.0, 6020.307664618537, 6030.006199628022, 6082.148499210114, 5463.48096930791, 5485.122380419114, 5494.780208791683, 5517.503424691797, 5543.113101903676, 6428.517861160338, 6435.324290949477, 6440.4847612190915, 6449.355064493513, 6454.5159113065765, 6116.082587611716, 6212.968935155295, 6237.656928868956, 6238.937610623836, 6242.937570624235, 6445.677716114269, 6470.644114573555, 6500.5449618526245, 6502.089707440868, 6529.020646903003, 6226.62640241587, 6232.626042437469, 6234.189555357774, 6250.937490625218, 6259.718312675849, 5679.233303503974, 6156.230471191101, 6184.845378865564, 6278.215223097113, 6279.748810047547, 5526.58550608714, 6093.2078829751845, 6137.048757442603, 6147.938520614915, 6157.168782214344, 6190.380961903774, 6208.192934918612, 6229.0967809668255, 6233.470155036873, 6241.812745617639, 5857.121431785266, 6103.0, 6109.1141784440115, 6113.354685976905, 6165.352637972948, 6211.565190436807, 6215.347388524321, 6217.626942383471, 6225.533085018732, 6227.657478838707, 6139.723712432862, 6140.3245642978345, 6159.014557670751, 6182.350853160354, 6188.597741146811], "unit": "score", "name": "dojo.html", "value": 5766.717019922756}, {"lowerIsBetter": false, "replicates": [415.68615695150174, 489.27342895799734, 500.0548962460948, 554.7004617506545, 592.9792457263997, 36713.81643091784, 37272.0, 37296.254074918485, 37413.438798418014, 37443.25113497728, 38324.04189895247, 38369.0, 38479.0, 39008.414873776914, 39107.41338879919, 9247.49138797366, 9424.434533927952, 9474.47890366033, 9512.524373781318, 9533.380330278509, 9260.0, 9510.144087032166, 9513.001134880842, 9557.996410376914, 9588.904110958905, 8264.917350826505, 9510.144087032166, 9558.80882382352, 9642.421454712705, 9665.855012174823, 9453.952730236339, 9534.380265282734, 9536.904630953672, 9553.283503737213, 9555.474448905308, 9442.763930901714, 9555.522223888778, 9574.186194173504, 9590.897046839633, 9606.039396060409, 37499.875003749934, 37762.811185943894, 37881.81059094687, 37903.81048094769, 37918.672846450245, 3200.7919485233383, 3218.4689526228144, 3256.6254880688552, 3441.4665726812386, 3653.2328211075705, 28213.576796348072, 28257.85871070652, 28479.57280640792, 28523.714762852313, 28594.714052859414, 2689.865506724656, 2706.742859428351, 2752.229375774786, 2851.472477591652, 2935.2074939766358, 489378.0, 491197.0, 492829.0, 496389.51805241103, 496764.0, 67435.3256467429, 67968.6601566989, 68050.65974670195, 68065.65967170133, 68250.0, 70359.0, 70888.0, 71388.28611713817, 71551.64224178846, 71677.28322716811, 16039.599010024842, 16491.09298988567, 16491.928024678356, 16540.503784886474, 16785.748213776802, 12723.55467558631, 12743.235405875677, 12805.231686098863, 12829.486820527261, 12851.16467429614, 18059.729104063448, 19239.711404328948, 19511.609767804566, 20239.886806225506, 21686.34940951774, 8121.0, 9521.476318802532, 9690.12788849007, 9714.514274286399, 9719.65981190655, 949.4588084791602, 977.9022097790164, 998.256299057207, 1001.0690058245756, 1002.1882275356838, 29655.110346689635, 30061.849690751405, 30254.84872575623, 30701.0, 30959.0, 1031.8091153136693, 1096.703889949709, 1109.4563663804677, 1109.6615532262576, 1182.6511179202157, 12377.62867113988, 12573.55404128537, 14274.85725142756, 14304.28478576067, 14406.711865762625, 638311.0, 641277.0, 650550.0, 656311.0, 657196.0, 47658.285125723145, 56546.43453565494, 56752.0, 56941.86116277651, 57093.0, 1341.4298922957703, 1379.951701690456, 1380.2960490150297, 1382.6059573021641, 1397.0220845408053, 27475.725242747318, 27729.0, 28049.01828435995, 28083.0, 28220.576691349237, 47116.0, 47150.585482435585, 47686.28470573013, 47735.04529909452, 47859.803504912656, 493759.0, 496933.0, 500278.0, 500588.99411006883, 503104.0, 25896.611550826376, 31657.525137122502, 32124.03627891167, 32232.19419514531, 32827.835860820545, 42759.57240427556, 42848.0, 43219.0, 43694.34458483189, 44094.77952610217, 35408.82295588506, 35867.82066089653, 35929.0, 36420.27159456743, 36701.0, 35242.82378588091, 35398.469022964164, 35782.0, 36025.63974360223, 36102.0, 33770.49344259887, 34622.65377346295, 34810.65189348074, 35089.0, 35434.822825885705, 30925.0, 31770.841145794122, 31940.5208921871, 32098.51852222172, 32107.357852842346, 19509.60980780405, 23508.52982940366, 23674.52650947006, 24041.51916961616, 24049.639255411534], "unit": "score", "name": "ext.html", "value": 19603.213230343878}, {"lowerIsBetter": false, "replicates": [358.7919006975953, 362.2067671798761, 369.538077403246, 375.1652573025018, 375.97932113733737, 19423.320183793552, 19496.51258718531, 20129.899350503227, 20131.597368052648, 20179.495512612193, 11727.589534366278, 11973.820392694117, 12111.818322725145, 12119.33343666098, 12137.39313034347, 5101.617378696604, 5339.70631615261, 5612.512684138706, 6062.424069713392, 6069.1199776032445, 5856.912146317809, 5955.464008239258, 5974.6713930733795, 5981.671008094553, 5985.16207730918, 4817.759112044401, 5017.824376146836, 5825.359210486843, 5833.358330583633, 5897.085951677497, 5675.858103547403, 5713.914356272295, 5736.598438109355, 5743.5118014968775, 6083.8174854754425, 5717.171010203498, 5735.225744524478, 5739.16782066598, 5766.279215098113, 5773.971130144322, 13598.524051658243, 13614.455421783117, 20942.685859712117, 25676.972921083136, 25756.87121564399, 2005.6189324028535, 2035.7048228006856, 2091.5150243327257, 2238.9776102238934, 2515.8490490570625, 9950.104490595808, 10587.311824731445, 11085.833712494239, 12465.065120115936, 14679.339429725687, 1762.5681707981498, 1768.5313391951142, 1788.2131861980688, 1793.2378739035858, 1822.7265910113456, 68068.6596567019, 89279.55360223158, 93250.06749932481, 105772.94227057784, 112058.0, 10968.396738179477, 11117.610883619034, 11150.944245278723, 11224.66326010221, 11408.0, 13495.392707328194, 13498.325083745773, 13512.729745405037, 13526.0, 13532.797008044887, 8398.0, 8422.0, 8550.657973681107, 8593.828123437495, 8604.956975215084, 8575.656973720981, 8737.825243495094, 8743.650253989896, 8744.300455963508, 8844.071372505794, 4472.418585583853, 4525.343825145335, 4528.366028755977, 4576.107659006462, 4576.839810606612, 1893.583411649435, 1922.8173323534243, 1940.427573865713, 1964.9705254421194, 1965.5282732144183, 927.6845872403416, 1035.6064695415694, 1052.1530168214508, 1078.164422572497, 1093.9224863509437, 20197.596048078954, 20652.79347206509, 20876.895615521826, 20941.057652405678, 21520.0, 848.1010129263001, 924.9768755781025, 985.0641890204334, 1026.9024442677933, 1043.4574021508772, 8197.4671646344, 10007.749806254757, 11040.668779936615, 11093.944530277297, 11142.164337674545, 547265.0, 612576.0, 613492.0, 624805.0, 624957.875210621, 121637.0, 122774.0, 125990.37004814917, 126427.0, 127021.0, 1039.142707266493, 1118.899299063072, 1120.1430905357408, 1171.4377098992532, 1175.735459521601, 17964.371247006293, 18240.0, 18424.907875460536, 19113.808861911202, 19155.71266430977, 49854.0, 49913.75043124761, 50245.74877125737, 51686.74156629193, 52553.68615784636, 62442.438939026884, 70845.58308833692, 72587.91118133126, 72791.0, 73074.63462682652, 7236.34872861445, 7898.960505197438, 7958.164392738679, 7978.481398709066, 8095.7166499172245, 9276.95361523215, 12304.569340073054, 12497.312647804458, 12709.237445752915, 12802.935985320013, 10672.199585031309, 10949.0, 11276.379799111128, 11333.206675532963, 11355.829662554903, 9746.658866939622, 10726.946365268124, 11075.280106793032, 11293.887061129284, 11303.321800691985, 11195.048420884315, 11224.775504490028, 11330.98021178098, 11525.0, 11602.013828824645, 7842.64708088126, 7897.091834439113, 7908.6045697713735, 7976.6410511525955, 8055.879161812694, 10135.543900524346, 11010.724731881766, 11446.198766086294, 11474.713132171762, 11495.597654082401], "unit": "score", "name": "jquery.html", "value": 9257.74684182004}, {"lowerIsBetter": false, "replicates": [1611.6696077304152, 1634.1339090282152, 1930.5270208798838, 1992.6712092504738, 2005.8696184747998, 6763.42510886574, 8039.91960080399, 8809.38334316598, 9000.549972501381, 9033.05152958939, 8712.215900568948, 8749.387542872002, 8825.293976481882, 8844.646214151426, 8870.112988701143, 2051.835853131746, 2068.3794861541514, 2484.043643197364, 2492.2149522900318, 2501.024600405843, 2464.556379851626, 2487.639292302615, 2493.4389762303426, 2501.487195124995, 2511.2842839790665, 2137.5724855029057, 2482.7889629381525, 2487.45276039272, 2518.244526642009, 2527.835690680109, 2479.194261864901, 2486.7388924162974, 2499.6500489931423, 2513.5978243481045, 2513.9748602513923, 2126.574685062978, 2470.147799009339, 2505.185814610259, 2506.862122583257, 2523.1673547729206, 8869.423487473357, 8919.554022298858, 8919.554022298924, 8928.821423571557, 8959.372843900865, 5469.124940009579, 5546.362168350651, 5592.552595792326, 5606.383297837235, 5610.551155907518, 3586.067622418164, 3715.3498137825773, 3720.9953312605717, 3733.8693145739767, 3738.9626103738888, 1032.5147180825, 1063.595833583241, 1065.222387657007, 1075.6826736112866, 1078.0, 11913.046956243566, 11988.400579971054, 12038.81941770874, 12065.939670301592, 12082.395880205955, 4862.076205521011, 4891.486393928586, 4994.750262486861, 5004.499550044967, 5017.247412888096, 10091.49542522871, 10135.543900524493, 10142.391456512632, 10144.492775361203, 10148.695539133838, 5577.860553486114, 5579.302587176603, 5582.63712858671, 5590.18942253371, 5594.776208951678, 4480.215962206601, 4859.635527335393, 5026.572741317029, 5048.419431765321, 5089.821856235014, 3920.2355540669296, 3963.425303331001, 3983.2830090583975, 4008.2785098681934, 4021.7586944783407, 1292.4959265886312, 1344.0658742174292, 1347.7169794343297, 1348.575198812371, 1355.0311527257861, 1139.7606502634374, 1311.967200819968, 1376.256821316478, 1396.6717821311984, 1407.4440595964536, 8145.933489610277, 8152.714654987047, 8228.0, 8228.259456648811, 8244.464109832841, 520.0301437818517, 527.7150338816996, 528.3897098850833, 528.9788408463695, 530.2179285553855, 6104.664243466563, 6175.413335733098, 6277.843053923597, 6329.9872020476505, 6372.7132279047555, 10394.22043346752, 10789.082927951213, 10808.78382432347, 10837.566497340018, 10863.402512861869, 10540.841887371696, 10636.840447393295, 10688.412137332365, 10723.14214862809, 10773.676789696321, 7172.318629730167, 8330.083690794008, 8409.83180336402, 8477.321814254845, 8511.97856257253, 7812.296893279632, 7841.019872515935, 7909.485883417559, 7917.406194535318, 7939.523628582304, 9334.533273336441, 9598.89612694549, 9709.951450242703, 9716.514174291116, 9730.978247283932, 9765.21878249724, 9852.950735246279, 10068.89931100709, 10085.899141008496, 10160.644377446753, 5710.371859095413, 6301.0, 6567.507436942344, 7181.138263408425, 7432.0, 7140.8214794628475, 8120.796980075545, 8142.877856832034, 8208.425410221227, 8236.382271329554, 6435.0, 7262.89105663426, 7329.193788683134, 7387.556746595222, 7496.362809161064, 7235.602041887747, 7238.6380680966795, 7278.199398066103, 7331.0, 7397.334239918433, 7752.92247077522, 7770.650320735467, 7788.376929845712, 7844.254795794391, 7850.0972388173805, 7015.36861682451, 7065.576065435885, 7070.964645176741, 7075.858482830417, 7085.14978202619, 6890.276520965427, 7110.715571377087, 7115.0, 7118.644067796693, 7144.607046612487], "unit": "score", "name": "mootools.html", "value": 4864.753486649312}, {"lowerIsBetter": false, "replicates": [331.64348325550037, 332.7304883044734, 336.76763033506893, 336.9258763072124, 344.05899863872304, 7010.123734533184, 7025.402840758542, 7088.893666594992, 7093.822654433642, 7097.964510177449, 6997.720091196346, 7009.264027277126, 7018.298170182979, 7022.262662420449, 7053.294670532944, 4251.404803327537, 4869.732164730938, 5080.339555857733, 5099.796008159669, 5143.562797162245, 5049.77276022578, 5055.51972562606, 5082.390113186404, 5084.084864724348, 5088.23676448532, 5007.7496125193775, 5014.473480284572, 5038.798448062092, 5050.747462626872, 5058.165402708549, 5013.0, 5068.72122033288, 5116.283720279164, 5119.513646203642, 5132.28148059272, 4363.716358436692, 4365.847195348148, 4371.388005679208, 4373.584509471595, 4387.802548885308, 6532.611924670866, 6574.342565743435, 6698.755916767888, 6728.899066514006, 6754.493412993996, 5931.317898441691, 5980.820575382745, 5991.850203744898, 6000.0, 6008.158857759917, 7395.778126656209, 7400.259974002557, 7414.221506741768, 7427.888581671279, 7427.994441500765, 3994.121293315466, 4864.610831133501, 4873.658843880929, 4881.096997055556, 4895.437024742165, 7621.580813055224, 7901.38021705549, 7904.051513818321, 7911.881321780178, 7952.840943181104, 4432.711873728197, 4731.361266229015, 4956.405231372259, 4986.376702912136, 5011.198208286657, 4112.177564487115, 4678.713353827725, 5098.1842905135, 5112.386513618315, 5113.590912726973, 5926.733297001645, 5957.106434034929, 5962.582619216613, 5970.194023806817, 5983.222181116514, 7455.925440745632, 7486.213947535539, 7490.812729681802, 7490.85018299631, 7530.096388433423, 1758.0067261997187, 1782.3049010885766, 1785.9374921877672, 1787.9553011174564, 1789.6152327249442, 1045.9058684718411, 1089.7929393415225, 1091.170710260208, 1097.8243481042996, 1099.2195541165702, 5781.595288329777, 6200.844978875474, 6585.715785421797, 6979.4765392594745, 7050.506464547432, 6502.7724029659685, 7714.691412343555, 7722.498037627536, 7731.536107833435, 7756.922430775733, 6539.574927629689, 7074.7170113195925, 7121.9643901780155, 7125.786226413215, 7154.606496642735, 3389.81356025416, 4108.815103320358, 4129.339305711072, 4144.544100148981, 4162.4796900387455, 6656.866862662817, 8227.42408031444, 8228.382871284677, 8236.958815206006, 8263.917360826435, 7759.418043646636, 8106.594670266463, 8107.067687215927, 8130.634121464548, 8156.714514992065, 8129.5122292661445, 8194.836103277901, 8201.917980820235, 8208.507489550646, 8216.46592971455, 7812.84374312522, 7818.866264391745, 7820.530768153929, 7837.725679601187, 7841.686332546634, 6160.476359509313, 7658.617069146632, 7686.3082322591235, 7688.46180767341, 7702.961485192538, 7925.445218834626, 8195.795105122419, 8219.301359384519, 8220.876686849582, 8242.958785206036, 4045.575214602542, 4783.497732738151, 4786.712797232177, 4819.7108173509705, 4823.831165909176, 7762.650680719268, 7789.376849852111, 7804.648790804541, 7809.297163255334, 7831.686732530635, 5962.449763061549, 7513.323800857949, 7530.623468826647, 7545.773626791205, 7567.432442566939, 7174.210836808052, 7527.924720752722, 7530.623468826647, 7548.698052077855, 7564.092308922965, 7313.414926805949, 7341.229170936975, 7343.265673432614, 7353.852922941404, 7375.151857536452, 7509.6245187739305, 7511.624418779148, 7513.661885215288, 7531.774046778605, 7538.246175382418, 7120.359167674934, 7342.6695798688115, 7352.669129889061, 7389.667464964197, 7393.778186654409], "unit": "score", "name": "prototype.html", "value": 5422.74096467652}, {"lowerIsBetter": false, "replicates": [632.9145565348676, 637.3371693438824, 660.385841167714, 680.6494655252549, 712.5688958180301, 13839.999999999975, 14205.289735513235, 15050.548483545484, 15416.152111633855, 15426.768598471019, 15717.921410392932, 15807.683846323067, 15873.92063039686, 15900.52298431049, 15913.840861591381, 739.7854622159581, 919.2829592917502, 933.351320832022, 936.2276122199179, 936.4381371177308, 919.6781126605667, 924.8427767279545, 930.5300823084333, 930.7626555228408, 933.2673851026946, 972.65470757881, 973.6154219083458, 982.287841315048, 985.5121714751173, 986.8371718666411, 947.4788866123639, 973.459729849933, 973.6202880876464, 976.9071938165933, 977.1791694976218, 563.3802816901417, 588.9676067816268, 717.0892965933288, 727.923568025355, 728.420905380224, 15100.0, 15351.232438378149, 15519.5344139676, 15737.213139343101, 15761.684766304725, 11491.94254028733, 12263.632091037283, 12352.320622365767, 12359.25844449336, 12436.689082772913, 9827.656032038843, 9910.35582687123, 9959.701208963743, 10161.441120738356, 10191.745206369826, 3387.5088112223834, 3423.9828800855835, 3430.142464383904, 3473.7394695397948, 3490.336836001152, 76100.61949690216, 78065.60967195184, 78764.21235787684, 81266.59366703128, 82571.58714206451, 9587.18508926735, 9605.0, 9646.987066357931, 9886.950565247127, 9892.80214395708, 21319.78680213209, 21345.78654213438, 21354.039068241967, 21365.78634213669, 21404.25085122013, 7566.35685966699, 7686.077670679442, 7688.269614386624, 7769.572673502898, 7880.921190788134, 4119.608637179464, 4178.12259425518, 4187.43469631602, 4197.790110494524, 4198.5591512891315, 3651.634836516327, 3695.0392897846214, 3704.0, 3708.49935258742, 3710.5547334319513, 655.4592461219513, 657.746767494518, 658.4370363339372, 661.9073329733841, 664.6145235763246, 540.9756560954767, 572.0732413490173, 591.1477122882026, 599.5203836930439, 607.3016031563737, 8259.752207433787, 8277.04813946404, 8316.459430137022, 8416.957915210385, 8513.233808957224, 565.547561950438, 599.0206013168414, 605.1572960335789, 610.081826850587, 611.8348046027547, 3694.8152592370275, 3870.8838734837436, 3922.7057970651745, 3973.1457736586194, 4048.438622124231, 73490.632546838, 91768.0823191773, 93968.0, 94430.0, 94544.0, 76203.61898190473, 78571.60714196392, 80635.0, 80745.59627201826, 81014.59492702616, 65522.0, 70634.0, 73565.0, 73777.26222737812, 75529.0, 8507.276881465144, 8552.743417697478, 8553.61508732096, 8645.740627781177, 8678.913210868062, 44321.99999999871, 49345.259821101994, 50728.0, 51200.719982000744, 51705.482945170064, 62463.37536624575, 68346.0, 68764.6561767188, 68856.311436887, 69262.65368673124, 10855.422468757359, 10872.945635271773, 10984.505697243483, 11262.605808796981, 11401.087912966777, 11882.346470944181, 11988.940055299669, 12025.63923082309, 12188.878111218773, 12198.390080495763, 11304.717382065513, 11384.943075284571, 11407.600733974272, 11462.484188211383, 11629.0, 11348.489317980546, 11564.363959982282, 11602.060990953303, 11735.002524785148, 12437.813432798695, 11017.283876548, 11384.54461821551, 11616.012638925786, 11623.12826537996, 12196.329201893981, 8894.066123056986, 9261.490618016074, 9527.809443811224, 9729.173020293354, 9859.852102218616, 8453.746387608382, 8652.0, 8879.91120088791, 9305.395149315273, 9511.904880951102], "unit": "score", "name": "yui.html", "value": 6948.133477073774}], "name": "dromaeo_css", "value": 7594.3456847482685}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 114.0, 116.0, 111.0, 127.0, 114.0, 113.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 114.3}, {"lowerIsBetter": true, "replicates": [162.0, 125.0, 149.0, 156.0, 127.0, 174.0, 169.0, 145.0, 159.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [195.0, 197.0, 201.0, 208.0, 206.0, 257.0, 197.0, 208.0, 201.0, 202.0], "unit": "score", "name": "audio-dft", "value": 207.2}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 64.0, 71.0, 66.0, 119.0, 63.0, 78.0, 85.0, 78.0], "unit": "score", "name": "audio-fft", "value": 73.6}, {"lowerIsBetter": true, "replicates": [81.0, 86.0, 119.0, 80.0, 79.0, 89.0, 115.0, 82.0, 79.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 92.5}, {"lowerIsBetter": true, "replicates": [93.0, 87.0, 76.0, 114.0, 135.0, 95.0, 91.0, 77.0, 119.0, 132.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 101.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 151.0, 90.0, 95.0, 95.0, 98.0, 100.0, 153.0, 98.0], "unit": "score", "name": "imaging-darkroom", "value": 107.2}, {"lowerIsBetter": true, "replicates": [90.0, 131.0, 140.0, 132.0, 133.0, 100.0, 99.0, 147.0, 143.0, 108.0], "unit": "score", "name": "imaging-desaturate", "value": 122.3}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 57.0, 55.0, 58.0, 59.0, 61.0, 81.0, 89.0, 83.0], "unit": "score", "name": "json-parse-financial", "value": 65.7}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 74.0, 92.0, 64.0, 95.0, 103.0, 103.0, 100.0, 85.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 85.6}, {"lowerIsBetter": true, "replicates": [87.0, 100.0, 108.0, 109.0, 109.0, 85.0, 85.0, 84.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.6}, {"lowerIsBetter": true, "replicates": [138.0, 142.0, 118.0, 124.0, 121.0, 121.0, 119.0, 120.0, 135.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.8}, {"lowerIsBetter": true, "replicates": [140.0, 154.0, 137.0, 141.0, 159.0, 181.0, 181.0, 143.0, 139.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 72.0, 68.0, 94.0, 98.0, 104.0, 75.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 78.2}], "name": "kraken", "value": 1569.5999999999997}]} 19:50:26 INFO - Return code: 0 19:50:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:50:26 ERROR - # TBPL SUCCESS # 19:50:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:50:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:50:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:50:26 INFO - 2016-03-21 19:50:26.632 screenresolution[1683:10226] starting screenresolution argv=screenresolution get 19:50:26 INFO - 2016-03-21 19:50:26.635 screenresolution[1683:10226] Display 0: 1600x1200x32@60 19:50:26 INFO - 2016-03-21 19:50:26.641 screenresolution[1684:10229] starting screenresolution argv=screenresolution list 19:50:26 INFO - Available Modes on Display 0 19:50:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:50:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:50:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:50:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:50:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:50:26 INFO - Intel Iris: 19:50:26 INFO - Chipset Model: Intel Iris 19:50:26 INFO - Type: GPU 19:50:26 INFO - Bus: Built-In 19:50:26 INFO - VRAM (Dynamic, Max): 1536 MB 19:50:26 INFO - Vendor: Intel (0x8086) 19:50:26 INFO - Device ID: 0x0a2e 19:50:26 INFO - Revision ID: 0x0009 19:50:26 INFO - Displays: 19:50:26 INFO - Display: 19:50:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:50:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:50:26 INFO - Display Serial Number: 1600x1200 60 19:50:26 INFO - Main Display: Yes 19:50:26 INFO - Mirror: Off 19:50:26 INFO - Online: Yes 19:50:26 INFO - Rotation: Supported 19:50:26 INFO - Return code: 0 19:50:26 INFO - Running post-action listener: _resource_record_post_action 19:50:26 INFO - Running post-run listener: _resource_record_post_run 19:50:27 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39458304; Write bytes: 708080128; Read time: 417; Write time: 2008 19:50:27 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 393835008; Write bytes: 393579520; Read time: 29775; Write time: 710 19:50:27 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 37664256; Write bytes: 302470656; Read time: 400; Write time: 1261 19:50:27 INFO - Running post-run listener: _upload_blobber_files 19:50:27 INFO - Blob upload gear active. 19:50:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:50:27 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 19:50:27 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'] 19:50:27 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 19:50:28 INFO - (blobuploader) - INFO - Open directory for files ... 19:50:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:50:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:50:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:29 INFO - (blobuploader) - INFO - Done attempting. 19:50:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:50:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:50:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:30 INFO - (blobuploader) - INFO - Done attempting. 19:50:30 INFO - (blobuploader) - INFO - Iteration through files over. 19:50:30 INFO - Return code: 0 19:50:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:50:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:50:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6d833b66328f3b7e5f13818f046510774046ab2e8aa1a8cd006b351a836b9c5812a012345e4340ab1c0201a7e366698aae15839ab498a23b0f8fa123e311719", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64d8b95b8d03b8edeaf0296d9ec9938e43fc76163383238c19d2842af771861bba22c2128874c9b6cb06bdb68c0b17f4d425184e18e9e7748175225287a1ed68"} 19:50:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:50:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:50:30 INFO - Contents: 19:50:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6d833b66328f3b7e5f13818f046510774046ab2e8aa1a8cd006b351a836b9c5812a012345e4340ab1c0201a7e366698aae15839ab498a23b0f8fa123e311719", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64d8b95b8d03b8edeaf0296d9ec9938e43fc76163383238c19d2842af771861bba22c2128874c9b6cb06bdb68c0b17f4d425184e18e9e7748175225287a1ed68"} 19:50:30 INFO - Running post-run listener: copy_logs_to_upload_dir 19:50:30 INFO - Copying logs to upload dir... 19:50:30 INFO - mkdir: /builds/slave/test/build/upload/logs 19:50:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.403378 ========= master_lag: 0.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-21 19:50:31.499874) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 19:50:31.507078) ========= 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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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/b6d833b66328f3b7e5f13818f046510774046ab2e8aa1a8cd006b351a836b9c5812a012345e4340ab1c0201a7e366698aae15839ab498a23b0f8fa123e311719", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64d8b95b8d03b8edeaf0296d9ec9938e43fc76163383238c19d2842af771861bba22c2128874c9b6cb06bdb68c0b17f4d425184e18e9e7748175225287a1ed68"} build_url:https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011045 build_url: 'https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6d833b66328f3b7e5f13818f046510774046ab2e8aa1a8cd006b351a836b9c5812a012345e4340ab1c0201a7e366698aae15839ab498a23b0f8fa123e311719", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64d8b95b8d03b8edeaf0296d9ec9938e43fc76163383238c19d2842af771861bba22c2128874c9b6cb06bdb68c0b17f4d425184e18e9e7748175225287a1ed68"}' ========= master_lag: 0.44 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 19:50:31.956437) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 19:50:31.956786) ========= 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.kpE5WmieyZ/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.P2RyMVOFSr/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.004578 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 19:50:32.025190) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 19:50:32.025503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 19:50:32.025984) ========= ========= Total master_lag: 1.33 =========