builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0136 starttime: 1457658407.74 results: success (0) buildid: 20160310150717 builduid: 1ca4746b148a4a368a4dfbb43ea5f313 revision: c1d6cd4595a03608cf23c1a6c136ea862dc37fc9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 17:06:47.737537) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 17:06:47.741975) ========= ========= Started set props: basedir (results: 0, elapsed: 6 secs) (at 2016-03-10 17:06:47.742288) ========= 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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005734 basedir: '/builds/slave/test' ========= master_lag: 6.92 ========= ========= Finished set props: basedir (results: 0, elapsed: 6 secs) (at 2016-03-10 17:06:54.664008) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 46 secs) (at 2016-03-10 17:06:54.664288) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 46 secs) (at 2016-03-10 17:07:40.702028) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-03-10 17:07:40.702328) ========= 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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.004955 ========= master_lag: 7.66 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-03-10 17:07:48.371148) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 17:07:48.371460) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 17:07:48.371857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2016-03-10 17:07:48.372138) ========= 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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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-10 17:07:49-- 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% 136M=0s 2016-03-10 17:07:49 (136 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131246 ========= master_lag: 11.37 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2016-03-10 17:07:59.873023) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 10 secs) (at 2016-03-10 17:07:59.873301) ========= 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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.019652 ========= master_lag: 9.98 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 10 secs) (at 2016-03-10 17:08:09.876143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2016-03-10 17:08:09.876460) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c1d6cd4595a03608cf23c1a6c136ea862dc37fc9 --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 c1d6cd4595a03608cf23c1a6c136ea862dc37fc9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3qtCyQPUH4/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.DR3GctQ2eC/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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-10 17:08:11,470 truncating revision to first 12 chars 2016-03-10 17:08:11,470 Setting DEBUG logging. 2016-03-10 17:08:11,470 attempt 1/10 2016-03-10 17:08:11,470 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c1d6cd4595a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-10 17:08:12,294 unpacking tar archive at: fx-team-c1d6cd4595a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.074645 ========= master_lag: 9.98 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2016-03-10 17:08:20.934100) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 9 secs) (at 2016-03-10 17:08:20.934412) ========= echo c1d6cd4595a03608cf23c1a6c136ea862dc37fc9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c1d6cd4595a03608cf23c1a6c136ea862dc37fc9'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3qtCyQPUH4/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.DR3GctQ2eC/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 c1d6cd4595a03608cf23c1a6c136ea862dc37fc9 program finished with exit code 0 elapsedTime=0.005476 script_repo_revision: 'c1d6cd4595a03608cf23c1a6c136ea862dc37fc9' ========= master_lag: 9.36 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 9 secs) (at 2016-03-10 17:08:30.296785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 24 secs) (at 2016-03-10 17:08:30.297077) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 24 secs) (at 2016-03-10 17:08:54.484173) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-10 17:08:54.484439) ========= /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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:08:54 INFO - MultiFileLogger online at 20160310 17:08:54 in /builds/slave/test 17:08:54 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 17:08:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:08:54 INFO - {'append_to_log': False, 17:08:54 INFO - 'base_work_dir': '/builds/slave/test', 17:08:54 INFO - 'blob_upload_branch': 'Fx-Team', 17:08:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:08:54 INFO - 'branch': 'Fx-Team', 17:08:54 INFO - 'buildbot_json_path': 'buildprops.json', 17:08:54 INFO - 'config_files': ('talos/mac_config.py',), 17:08:54 INFO - 'default_actions': ('clobber', 17:08:54 INFO - 'read-buildbot-config', 17:08:54 INFO - 'download-and-extract', 17:08:54 INFO - 'populate-webroot', 17:08:54 INFO - 'create-virtualenv', 17:08:54 INFO - 'install', 17:08:54 INFO - 'run-tests'), 17:08:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:08:54 INFO - 'download_minidump_stackwalk': True, 17:08:54 INFO - 'download_symbols': 'ondemand', 17:08:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:08:54 INFO - 'tooltool.py': '/tools/tooltool.py', 17:08:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:08:54 INFO - '/tools/misc-python/virtualenv.py')}, 17:08:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:08:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:08:54 INFO - 'installer_path': 'installer.exe', 17:08:54 INFO - 'log_level': 'info', 17:08:54 INFO - 'log_name': 'talos', 17:08:54 INFO - 'log_to_console': True, 17:08:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:08:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:08:54 INFO - 'opt_config_files': (), 17:08:54 INFO - 'pip_index': False, 17:08:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:08:54 INFO - 'cmd': ('bash', 17:08:54 INFO - '-c', 17:08:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:08:54 INFO - 'enabled': True, 17:08:54 INFO - 'halt_on_failure': False, 17:08:54 INFO - 'name': 'check_screen_resolution'},), 17:08:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:08:54 INFO - 'cmd': ('bash', 17:08:54 INFO - '-c', 17:08:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:08:54 INFO - 'enabled': True, 17:08:54 INFO - 'halt_on_failure': False, 17:08:54 INFO - 'name': 'check_screen_resolution'},), 17:08:54 INFO - 'run_cmd_checks_enabled': True, 17:08:54 INFO - 'sps_profile': False, 17:08:54 INFO - 'sps_profile_interval': 0, 17:08:54 INFO - 'suite': 'dromaeojs-e10s', 17:08:54 INFO - 'system_bits': '32', 17:08:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:08:54 INFO - 'title': 't-yosemite-r7-0136', 17:08:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:08:54 INFO - 'use_talos_json': True, 17:08:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:08:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:08:54 INFO - 'work_dir': 'build'} 17:08:54 INFO - ##### 17:08:54 INFO - ##### Running clobber step. 17:08:54 INFO - ##### 17:08:54 INFO - Running pre-action listener: _resource_record_pre_action 17:08:54 INFO - Running main action method: clobber 17:08:54 INFO - rmtree: /builds/slave/test/build 17:08:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:08:56 INFO - Running post-action listener: _resource_record_post_action 17:08:56 INFO - ##### 17:08:56 INFO - ##### Running read-buildbot-config step. 17:08:56 INFO - ##### 17:08:56 INFO - Running pre-action listener: _resource_record_pre_action 17:08:56 INFO - Running main action method: read_buildbot_config 17:08:56 INFO - Using buildbot properties: 17:08:56 INFO - { 17:08:56 INFO - "project": "", 17:08:56 INFO - "product": "firefox", 17:08:56 INFO - "script_repo_revision": "production", 17:08:56 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:08:56 INFO - "repository": "", 17:08:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:08:56 INFO - "buildid": "20160310150717", 17:08:56 INFO - "pgo_build": "False", 17:08:56 INFO - "basedir": "/builds/slave/test", 17:08:56 INFO - "buildnumber": 610, 17:08:56 INFO - "slavename": "t-yosemite-r7-0136", 17:08:56 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:08:56 INFO - "platform": "yosemite_r7", 17:08:56 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 17:08:56 INFO - "branch": "fx-team", 17:08:56 INFO - "repo_path": "integration/fx-team", 17:08:56 INFO - "revision": "c1d6cd4595a03608cf23c1a6c136ea862dc37fc9", 17:08:56 INFO - "stage_platform": "macosx64", 17:08:56 INFO - "builduid": "1ca4746b148a4a368a4dfbb43ea5f313", 17:08:56 INFO - "slavebuilddir": "test" 17:08:56 INFO - } 17:08:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 17:08:56 INFO - Running post-action listener: _resource_record_post_action 17:08:56 INFO - ##### 17:08:56 INFO - ##### Running download-and-extract step. 17:08:56 INFO - ##### 17:08:56 INFO - Running pre-action listener: _resource_record_pre_action 17:08:56 INFO - Running main action method: download_and_extract 17:08:56 INFO - mkdir: /builds/slave/test/build/tests 17:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:56 INFO - https://queue.taskcluster.net/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:08:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:08:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:08:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/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 17:08:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/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 17:08:58 INFO - Downloaded 1199 bytes. 17:08:58 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:08:58 INFO - Using the following test package requirements: 17:08:58 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:08:58 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:08:58 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 17:08:58 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:08:58 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 17:08:58 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:08:58 INFO - u'jsshell-mac.zip'], 17:08:58 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:08:58 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 17:08:58 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:08:58 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:08:58 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 17:08:58 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:08:58 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 17:08:58 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:08:58 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 17:08:58 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:08:58 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 17:08:58 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:58 INFO - https://queue.taskcluster.net/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:08:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:08:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:08:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/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 17:08:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/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 17:08:59 INFO - Downloaded 17867585 bytes. 17:08:59 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'] 17:08:59 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 17:09:02 INFO - Return code: 0 17:09:02 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 17:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:02 INFO - https://queue.taskcluster.net/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:09:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:09:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:09:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/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 17:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/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 17:09:03 INFO - Downloaded 17867585 bytes. 17:09:03 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'] 17:09:03 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 17:09:07 INFO - Return code: 0 17:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:07 INFO - https://queue.taskcluster.net/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:09:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:09:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:09:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/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 17:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/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 17:09:08 INFO - Downloaded 10845161 bytes. 17:09:08 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'] 17:09:08 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 17:09:09 INFO - Return code: 0 17:09: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')]} 17:09:09 INFO - https://queue.taskcluster.net/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:09:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:09:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:09:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 17:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCW95t1IS0257dABuoFLig/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 17:09:11 INFO - Downloaded 110987549 bytes. 17:09:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:09:11 INFO - mkdir: /builds/slave/test/properties 17:09:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:09:11 INFO - Writing to file /builds/slave/test/properties/build_url 17:09:11 INFO - Contents: 17:09:11 INFO - build_url:https://queue.taskcluster.net/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:09:12 INFO - Running post-action listener: _resource_record_post_action 17:09:12 INFO - Running post-action listener: set_extra_try_arguments 17:09:12 INFO - ##### 17:09:12 INFO - ##### Running populate-webroot step. 17:09:12 INFO - ##### 17:09:12 INFO - Running pre-action listener: _resource_record_pre_action 17:09:12 INFO - Running main action method: populate_webroot 17:09:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:09:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:09:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:09:12 INFO - '--tppagecycles', 17:09:12 INFO - '7'], 17:09:12 INFO - 'tests': ['tsvgm']}}, 17:09:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:09:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:09:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:09:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:09:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:09:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:09:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:12 INFO - 'talos_options': ['--e10s'], 17:09:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:12 INFO - 'tests': ['damp', 'tps']}, 17:09:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:12 INFO - 'talos_options': ['--e10s'], 17:09:12 INFO - 'tests': ['damp', 'tps']}, 17:09:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:09:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:09:12 INFO - 'other': {'tests': ['a11yr', 17:09:12 INFO - 'ts_paint', 17:09:12 INFO - 'tpaint', 17:09:12 INFO - 'sessionrestore', 17:09:12 INFO - 'sessionrestore_no_auto_restore', 17:09:12 INFO - 'tabpaint']}, 17:09:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:09:12 INFO - 'tests': ['a11yr', 17:09:12 INFO - 'ts_paint', 17:09:12 INFO - 'tpaint', 17:09:12 INFO - 'sessionrestore', 17:09:12 INFO - 'sessionrestore_no_auto_restore', 17:09:12 INFO - 'tabpaint']}, 17:09:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:09:12 INFO - 'tests': ['a11yr', 17:09:12 INFO - 'ts_paint', 17:09:12 INFO - 'tpaint', 17:09:12 INFO - 'sessionrestore', 17:09:12 INFO - 'sessionrestore_no_auto_restore', 17:09:12 INFO - 'tabpaint']}, 17:09:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:09:12 INFO - 'tests': ['a11yr', 17:09:12 INFO - 'ts_paint', 17:09:12 INFO - 'tpaint', 17:09:12 INFO - 'sessionrestore', 17:09:12 INFO - 'sessionrestore_no_auto_restore', 17:09:12 INFO - 'tabpaint']}, 17:09:12 INFO - 'other_l64': {'tests': ['a11yr', 17:09:12 INFO - 'ts_paint', 17:09:12 INFO - 'tpaint', 17:09:12 INFO - 'sessionrestore', 17:09:12 INFO - 'sessionrestore_no_auto_restore', 17:09:12 INFO - 'tabpaint']}, 17:09:12 INFO - 'other_nol64': {'tests': ['a11yr', 17:09:12 INFO - 'ts_paint', 17:09:12 INFO - 'tpaint', 17:09:12 INFO - 'sessionrestore', 17:09:12 INFO - 'sessionrestore_no_auto_restore', 17:09:12 INFO - 'tabpaint']}, 17:09:12 INFO - 'svgr': {'tests': ['tsvgx', 17:09:12 INFO - 'tsvgr_opacity', 17:09:12 INFO - 'tart', 17:09:12 INFO - 'tscrollx', 17:09:12 INFO - 'cart']}, 17:09:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:09:12 INFO - 'tests': ['tsvgx', 17:09:12 INFO - 'tsvgr_opacity', 17:09:12 INFO - 'tart', 17:09:12 INFO - 'tscrollx', 17:09:12 INFO - 'cart']}, 17:09:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:12 INFO - 'tests': ['tp5o']}, 17:09:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:12 INFO - 'talos_options': ['--e10s'], 17:09:12 INFO - 'tests': ['tp5o']}, 17:09:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:12 INFO - 'talos_options': ['--xperf_path', 17:09:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:12 INFO - 'tests': ['tp5n']}, 17:09:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:12 INFO - 'talos_options': ['--e10s', 17:09:12 INFO - '--xperf_path', 17:09:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:12 INFO - 'tests': ['tp5n']}}, 17:09:12 INFO - 'talos.zip': {'path': '', 17:09:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:09:12 INFO - Running post-action listener: _resource_record_post_action 17:09:12 INFO - ##### 17:09:12 INFO - ##### Running create-virtualenv step. 17:09:12 INFO - ##### 17:09:12 INFO - Running pre-action listener: _resource_record_pre_action 17:09:12 INFO - Running main action method: create_virtualenv 17:09:12 INFO - Creating virtualenv /builds/slave/test/build/venv 17:09:12 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 17:09:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:09:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:09:12 INFO - Using real prefix '/tools/python27' 17:09:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:09:13 INFO - Installing distribute.............................................................................................................................................................................................done. 17:09:16 INFO - Installing pip.................done. 17:09:16 INFO - Return code: 0 17:09:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:09:16 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')]} 17:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:16 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')]} 17:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:16 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 0x101ea0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ea74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe83d709d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d44d30>, '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 0x101b68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d3bb20>, '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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:16 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 17:09:16 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 17:09:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qtCyQPUH4/Render', 17:09:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:16 INFO - 'HOME': '/Users/cltbld', 17:09:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:16 INFO - 'LOGNAME': 'cltbld', 17:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:16 INFO - 'MOZ_NO_REMOTE': '1', 17:09:16 INFO - 'NO_EM_RESTART': '1', 17:09:16 INFO - 'PAGER': '/bin/cat', 17:09:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:16 INFO - 'PWD': '/builds/slave/test', 17:09:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:16 INFO - 'SHELL': '/bin/bash', 17:09:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DR3GctQ2eC/Listeners', 17:09:16 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:16 INFO - 'USER': 'cltbld', 17:09:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:16 INFO - 'XPC_FLAGS': '0x0', 17:09:16 INFO - 'XPC_SERVICE_NAME': '0', 17:09:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:16 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 17:09:16 INFO - Cleaning up... 17:09:16 INFO - Return code: 0 17:09:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:09:16 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')]} 17:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:16 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')]} 17:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:16 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 0x101ea0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ea74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe83d709d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d44d30>, '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 0x101b68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d3bb20>, '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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:16 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 17:09:16 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 17:09:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qtCyQPUH4/Render', 17:09:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:16 INFO - 'HOME': '/Users/cltbld', 17:09:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:16 INFO - 'LOGNAME': 'cltbld', 17:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:16 INFO - 'MOZ_NO_REMOTE': '1', 17:09:16 INFO - 'NO_EM_RESTART': '1', 17:09:16 INFO - 'PAGER': '/bin/cat', 17:09:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:16 INFO - 'PWD': '/builds/slave/test', 17:09:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:16 INFO - 'SHELL': '/bin/bash', 17:09:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DR3GctQ2eC/Listeners', 17:09:16 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:16 INFO - 'USER': 'cltbld', 17:09:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:16 INFO - 'XPC_FLAGS': '0x0', 17:09:16 INFO - 'XPC_SERVICE_NAME': '0', 17:09:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:16 INFO - Downloading/unpacking psutil>=0.7.1 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:09:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:20 INFO - Installing collected packages: psutil 17:09:20 INFO - Running setup.py install for psutil 17:09:20 INFO - building 'psutil._psutil_osx' extension 17:09:20 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 17:09:20 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 17:09:20 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 17:09:20 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 17:09:20 INFO - building 'psutil._psutil_posix' extension 17:09:20 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 17:09:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:09:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:09:20 INFO - ^ 17:09:20 INFO - 1 warning generated. 17:09:20 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 17:09:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:20 INFO - Successfully installed psutil 17:09:20 INFO - Cleaning up... 17:09:21 INFO - Return code: 0 17:09:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:21 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 0x101ea0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ea74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe83d709d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d44d30>, '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 0x101b68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d3bb20>, '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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:21 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 17:09:21 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 17:09:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qtCyQPUH4/Render', 17:09:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:21 INFO - 'HOME': '/Users/cltbld', 17:09:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:21 INFO - 'LOGNAME': 'cltbld', 17:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:21 INFO - 'MOZ_NO_REMOTE': '1', 17:09:21 INFO - 'NO_EM_RESTART': '1', 17:09:21 INFO - 'PAGER': '/bin/cat', 17:09:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:21 INFO - 'PWD': '/builds/slave/test', 17:09:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:21 INFO - 'SHELL': '/bin/bash', 17:09:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DR3GctQ2eC/Listeners', 17:09:21 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:21 INFO - 'USER': 'cltbld', 17:09:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:21 INFO - 'XPC_FLAGS': '0x0', 17:09:21 INFO - 'XPC_SERVICE_NAME': '0', 17:09:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:09:23 INFO - Installing collected packages: mozsystemmonitor 17:09:23 INFO - Running setup.py install for mozsystemmonitor 17:09:23 INFO - Successfully installed mozsystemmonitor 17:09:23 INFO - Cleaning up... 17:09:23 INFO - Return code: 0 17:09:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101ea0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ea74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe83d709d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d44d30>, '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 0x101b68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d3bb20>, '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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:09:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qtCyQPUH4/Render', 17:09:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:23 INFO - 'HOME': '/Users/cltbld', 17:09:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:23 INFO - 'LOGNAME': 'cltbld', 17:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:23 INFO - 'MOZ_NO_REMOTE': '1', 17:09:23 INFO - 'NO_EM_RESTART': '1', 17:09:23 INFO - 'PAGER': '/bin/cat', 17:09:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:23 INFO - 'PWD': '/builds/slave/test', 17:09:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:23 INFO - 'SHELL': '/bin/bash', 17:09:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DR3GctQ2eC/Listeners', 17:09:23 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:23 INFO - 'USER': 'cltbld', 17:09:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:23 INFO - 'XPC_FLAGS': '0x0', 17:09:23 INFO - 'XPC_SERVICE_NAME': '0', 17:09:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:24 INFO - Downloading/unpacking blobuploader==1.2.4 17:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:26 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:09:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:27 INFO - Downloading docopt-0.6.1.tar.gz 17:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:09:27 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:27 INFO - Running setup.py install for blobuploader 17:09:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:09:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:09:27 INFO - Running setup.py install for requests 17:09:28 INFO - Running setup.py install for docopt 17:09:28 INFO - Successfully installed blobuploader requests docopt 17:09:28 INFO - Cleaning up... 17:09:28 INFO - Return code: 0 17:09:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:28 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 0x101ea0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ea74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe83d709d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d44d30>, '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 0x101b68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d3bb20>, '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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:28 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 17:09:28 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 17:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qtCyQPUH4/Render', 17:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:28 INFO - 'HOME': '/Users/cltbld', 17:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:28 INFO - 'LOGNAME': 'cltbld', 17:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:28 INFO - 'MOZ_NO_REMOTE': '1', 17:09:28 INFO - 'NO_EM_RESTART': '1', 17:09:28 INFO - 'PAGER': '/bin/cat', 17:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:28 INFO - 'PWD': '/builds/slave/test', 17:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:28 INFO - 'SHELL': '/bin/bash', 17:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DR3GctQ2eC/Listeners', 17:09:28 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:28 INFO - 'USER': 'cltbld', 17:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:28 INFO - 'XPC_FLAGS': '0x0', 17:09:28 INFO - 'XPC_SERVICE_NAME': '0', 17:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:28 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-hJcb_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:28 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-qyjJUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-vAPWYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-ZP0QCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Uqk0Rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-d_Mp8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-PjX_eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-MG8q4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-no2jvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-VRyNDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-YRRYUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-4ZU71r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:30 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-hXucfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:30 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-lQfmOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:30 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-28e6rR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:30 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-hr5PTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:30 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-0IzsTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:30 INFO - Running setup.py install for manifestparser 17:09:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:09:30 INFO - Running setup.py install for mozcrash 17:09:30 INFO - Running setup.py install for mozdebug 17:09:31 INFO - Running setup.py install for mozdevice 17:09:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:09:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:09:31 INFO - Running setup.py install for mozfile 17:09:31 INFO - Running setup.py install for mozhttpd 17:09:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:09:31 INFO - Running setup.py install for mozinfo 17:09:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:09:31 INFO - Running setup.py install for mozInstall 17:09:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:09:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:09:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:09:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:09:31 INFO - Running setup.py install for mozleak 17:09:31 INFO - Running setup.py install for mozlog 17:09:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:09:32 INFO - Running setup.py install for moznetwork 17:09:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:09:32 INFO - Running setup.py install for mozprocess 17:09:32 INFO - Running setup.py install for mozprofile 17:09:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:09:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:09:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:09:32 INFO - Running setup.py install for mozrunner 17:09:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:09:32 INFO - Running setup.py install for mozscreenshot 17:09:32 INFO - Running setup.py install for moztest 17:09:33 INFO - Running setup.py install for mozversion 17:09:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:09:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:09:33 INFO - Cleaning up... 17:09:33 INFO - Return code: 0 17:09:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:33 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 0x101ea0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ea74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe83d709d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d44d30>, '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 0x101b68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d3bb20>, '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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:33 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 17:09:33 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 17:09:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qtCyQPUH4/Render', 17:09:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:33 INFO - 'HOME': '/Users/cltbld', 17:09:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:33 INFO - 'LOGNAME': 'cltbld', 17:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:33 INFO - 'MOZ_NO_REMOTE': '1', 17:09:33 INFO - 'NO_EM_RESTART': '1', 17:09:33 INFO - 'PAGER': '/bin/cat', 17:09:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:33 INFO - 'PWD': '/builds/slave/test', 17:09:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:33 INFO - 'SHELL': '/bin/bash', 17:09:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DR3GctQ2eC/Listeners', 17:09:33 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:33 INFO - 'USER': 'cltbld', 17:09:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:33 INFO - 'XPC_FLAGS': '0x0', 17:09:33 INFO - 'XPC_SERVICE_NAME': '0', 17:09:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:33 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-uRVOF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:33 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)) 17:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:33 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-3gWZJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:33 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)) 17:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:33 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-YI5i6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:33 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)) 17:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:33 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-qGs0GE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:33 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)) 17:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:33 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-GfpKS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:33 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)) 17:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:33 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Z83JQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:34 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)) 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-x_v1bm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:34 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)) 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-xWnmUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:34 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)) 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-tSKHXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:34 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)) 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-poYk6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:34 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)) 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-IOHAuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:34 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)) 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-v8DMsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:34 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)) 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-_pGYIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:34 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)) 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Sq4RdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:34 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)) 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-LO3Rur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:35 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Gz1rik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:35 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-VtaCO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:35 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)) 17:09:35 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)) 17:09:35 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)) 17:09:35 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)) 17:09:35 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)) 17:09:35 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)) 17:09:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:09:35 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 17:09:35 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 17:09:35 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 17:09:35 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 17:09:35 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 17:09:35 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 17:09:37 INFO - Downloading blessings-1.6.tar.gz 17:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:09:37 INFO - Installing collected packages: blessings 17:09:37 INFO - Running setup.py install for blessings 17:09:37 INFO - Successfully installed blessings 17:09:37 INFO - Cleaning up... 17:09:37 INFO - Return code: 0 17:09:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:38 INFO - Reading from file tmpfile_stdout 17:09:38 INFO - Current package versions: 17:09:38 INFO - blessings == 1.6 17:09:38 INFO - blobuploader == 1.2.4 17:09:38 INFO - docopt == 0.6.1 17:09:38 INFO - manifestparser == 1.1 17:09:38 INFO - mozInstall == 1.12 17:09:38 INFO - mozcrash == 0.17 17:09:38 INFO - mozdebug == 0.1 17:09:38 INFO - mozdevice == 0.48 17:09:38 INFO - mozfile == 1.2 17:09:38 INFO - mozhttpd == 0.7 17:09:38 INFO - mozinfo == 0.9 17:09:38 INFO - mozleak == 0.1 17:09:38 INFO - mozlog == 3.1 17:09:38 INFO - moznetwork == 0.27 17:09:38 INFO - mozprocess == 0.22 17:09:38 INFO - mozprofile == 0.28 17:09:38 INFO - mozrunner == 6.11 17:09:38 INFO - mozscreenshot == 0.1 17:09:38 INFO - mozsystemmonitor == 0.0 17:09:38 INFO - moztest == 0.7 17:09:38 INFO - mozversion == 1.4 17:09:38 INFO - psutil == 3.1.1 17:09:38 INFO - requests == 1.2.3 17:09:38 INFO - wsgiref == 0.1.2 17:09:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:38 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 0x101ea0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ea74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe83d709d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d44d30>, '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 0x101b68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d3bb20>, '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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:38 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 17:09:38 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 17:09:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qtCyQPUH4/Render', 17:09:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:38 INFO - 'HOME': '/Users/cltbld', 17:09:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:38 INFO - 'LOGNAME': 'cltbld', 17:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:38 INFO - 'MOZ_NO_REMOTE': '1', 17:09:38 INFO - 'NO_EM_RESTART': '1', 17:09:38 INFO - 'PAGER': '/bin/cat', 17:09:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:38 INFO - 'PWD': '/builds/slave/test', 17:09:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:38 INFO - 'SHELL': '/bin/bash', 17:09:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DR3GctQ2eC/Listeners', 17:09:38 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:38 INFO - 'USER': 'cltbld', 17:09:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:38 INFO - 'XPC_FLAGS': '0x0', 17:09:38 INFO - 'XPC_SERVICE_NAME': '0', 17:09:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 INFO - Cleaning up... 17:09:38 INFO - Return code: 0 17:09:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:38 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 0x101ea0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ea74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe83d709d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d44d30>, '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 0x101b68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d3bb20>, '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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:38 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 17:09:38 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 17:09:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qtCyQPUH4/Render', 17:09:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:38 INFO - 'HOME': '/Users/cltbld', 17:09:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:38 INFO - 'LOGNAME': 'cltbld', 17:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:38 INFO - 'MOZ_NO_REMOTE': '1', 17:09:38 INFO - 'NO_EM_RESTART': '1', 17:09:38 INFO - 'PAGER': '/bin/cat', 17:09:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:38 INFO - 'PWD': '/builds/slave/test', 17:09:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:38 INFO - 'SHELL': '/bin/bash', 17:09:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DR3GctQ2eC/Listeners', 17:09:38 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:38 INFO - 'USER': 'cltbld', 17:09:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:38 INFO - 'XPC_FLAGS': '0x0', 17:09:38 INFO - 'XPC_SERVICE_NAME': '0', 17:09:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:38 INFO - Downloading/unpacking jsonschema 17:09:38 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 17:09:38 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 17:09:38 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 17:09:38 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 17:09:38 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 17:09:38 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 17:09:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:09:41 INFO - Downloading/unpacking functools32 (from jsonschema) 17:09:41 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 17:09:41 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 17:09:41 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 17:09:41 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 17:09:41 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 17:09:41 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 17:09:41 INFO - Downloading functools32-3.2.3-2.tar.gz 17:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:09:41 INFO - warning: no files found matching '*.txt' 17:09:41 INFO - no previously-included directories found matching 'build' 17:09:41 INFO - no previously-included directories found matching 'dist' 17:09:41 INFO - no previously-included directories found matching '.git*' 17:09:41 INFO - Installing collected packages: jsonschema, functools32 17:09:41 INFO - Running setup.py install for functools32 17:09:41 INFO - warning: no files found matching '*.txt' 17:09:41 INFO - no previously-included directories found matching 'build' 17:09:41 INFO - no previously-included directories found matching 'dist' 17:09:41 INFO - no previously-included directories found matching '.git*' 17:09:41 INFO - Successfully installed jsonschema functools32 17:09:41 INFO - Cleaning up... 17:09:41 INFO - Return code: 0 17:09:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:41 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 0x101ea0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ea74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe83d709d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d44d30>, '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 0x101b68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d3bb20>, '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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:41 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 17:09:41 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 17:09:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qtCyQPUH4/Render', 17:09:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:41 INFO - 'HOME': '/Users/cltbld', 17:09:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:41 INFO - 'LOGNAME': 'cltbld', 17:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:41 INFO - 'MOZ_NO_REMOTE': '1', 17:09:41 INFO - 'NO_EM_RESTART': '1', 17:09:41 INFO - 'PAGER': '/bin/cat', 17:09:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:41 INFO - 'PWD': '/builds/slave/test', 17:09:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:41 INFO - 'SHELL': '/bin/bash', 17:09:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DR3GctQ2eC/Listeners', 17:09:41 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:41 INFO - 'USER': 'cltbld', 17:09:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:41 INFO - 'XPC_FLAGS': '0x0', 17:09:41 INFO - 'XPC_SERVICE_NAME': '0', 17:09:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:42 INFO - Downloading/unpacking flake8 17:09:42 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 17:09:42 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 17:09:42 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 17:09:42 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 17:09:42 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 17:09:42 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 17:09:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:09:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:09:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:09:45 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 17:09:45 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 17:09:45 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 17:09:45 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 17:09:45 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 17:09:45 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 17:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:09:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:09:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:09:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:09:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:09:45 INFO - no previously-included directories found matching 'docs/_build' 17:09:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:09:45 INFO - Running setup.py install for pep8 17:09:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:09:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:09:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:09:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:09:45 INFO - no previously-included directories found matching 'docs/_build' 17:09:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:09:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:09:45 INFO - Cleaning up... 17:09:45 INFO - Return code: 0 17:09:45 INFO - Running post-action listener: _resource_record_post_action 17:09:45 INFO - Running post-action listener: _start_resource_monitoring 17:09:45 INFO - Starting resource monitoring. 17:09:45 INFO - ##### 17:09:45 INFO - ##### Running install step. 17:09:45 INFO - ##### 17:09:45 INFO - Running pre-action listener: _resource_record_pre_action 17:09:45 INFO - Running main action method: install 17:09:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:46 INFO - Reading from file tmpfile_stdout 17:09:46 INFO - Detecting whether we're running mozinstall >=1.0... 17:09:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:09:46 INFO - Reading from file tmpfile_stdout 17:09:46 INFO - Output received: 17:09:46 INFO - Usage: mozinstall [options] installer 17:09:46 INFO - Options: 17:09:46 INFO - -h, --help show this help message and exit 17:09:46 INFO - -d DEST, --destination=DEST 17:09:46 INFO - Directory to install application into. [default: 17:09:46 INFO - "/builds/slave/test"] 17:09:46 INFO - --app=APP Application being installed. [default: firefox] 17:09:46 INFO - mkdir: /builds/slave/test/build/application 17:09:46 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'] 17:09:46 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 17:10:19 INFO - Reading from file tmpfile_stdout 17:10:19 INFO - Output received: 17:10:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:10:19 INFO - Running post-action listener: _resource_record_post_action 17:10:19 INFO - ##### 17:10:19 INFO - ##### Running run-tests step. 17:10:19 INFO - ##### 17:10:19 INFO - Running pre-action listener: _resource_record_pre_action 17:10:19 INFO - Running main action method: run_tests 17:10:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:10:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:10:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:10:19 INFO - 2016-03-10 17:10:19.725 screenresolution[1993:10929] starting screenresolution argv=screenresolution get 17:10:19 INFO - 2016-03-10 17:10:19.728 screenresolution[1993:10929] Display 0: 1600x1200x32@60 17:10:19 INFO - 2016-03-10 17:10:19.734 screenresolution[1994:10931] starting screenresolution argv=screenresolution list 17:10:19 INFO - Available Modes on Display 0 17:10:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:10:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:10:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:10:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:10:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:10:19 INFO - Intel Iris: 17:10:19 INFO - Chipset Model: Intel Iris 17:10:19 INFO - Type: GPU 17:10:19 INFO - Bus: Built-In 17:10:19 INFO - VRAM (Dynamic, Max): 1536 MB 17:10:19 INFO - Vendor: Intel (0x8086) 17:10:19 INFO - Device ID: 0x0a2e 17:10:19 INFO - Revision ID: 0x0009 17:10:19 INFO - Displays: 17:10:19 INFO - Display: 17:10:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:10:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:10:19 INFO - Display Serial Number: 1600x1200 60 17:10:19 INFO - Main Display: Yes 17:10:19 INFO - Mirror: Off 17:10:19 INFO - Online: Yes 17:10:19 INFO - Rotation: Supported 17:10:19 INFO - Return code: 0 17:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:10:19 INFO - Python 2.7.3 17:10:19 INFO - Return code: 0 17:10:19 INFO - grabbing minidump binary from tooltool 17:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:19 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 0x101d44d30>, '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 0x101b68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d3bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:10:19 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 17:10:19 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 17:10:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:10:20 INFO - Return code: 0 17:10:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:10:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:10:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:10:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:10:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:10:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:10:21 INFO - Return code: 0 17:10:21 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/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--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 17:10:21 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/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0136 --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 17:10:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qtCyQPUH4/Render', 17:10:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:21 INFO - 'HOME': '/Users/cltbld', 17:10:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:21 INFO - 'LOGNAME': 'cltbld', 17:10:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:10:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:21 INFO - 'MOZ_NO_REMOTE': '1', 17:10:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:10:21 INFO - 'NO_EM_RESTART': '1', 17:10:21 INFO - 'PAGER': '/bin/cat', 17:10:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:21 INFO - 'PWD': '/builds/slave/test', 17:10:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:10:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:21 INFO - 'SHELL': '/bin/bash', 17:10:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DR3GctQ2eC/Listeners', 17:10:21 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:10:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:21 INFO - 'USER': 'cltbld', 17:10:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:21 INFO - 'XPC_FLAGS': '0x0', 17:10:21 INFO - 'XPC_SERVICE_NAME': '0', 17:10:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:21 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/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--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 17:10:21 INFO - mozversion application_buildid: 20160310150717 17:10:21 INFO - mozversion application_changeset: c1d6cd4595a03608cf23c1a6c136ea862dc37fc9 17:10:21 INFO - mozversion application_display_name: Nightly 17:10:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:10:21 INFO - mozversion application_name: Firefox 17:10:21 INFO - mozversion application_remotingname: firefox 17:10:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:10:21 INFO - mozversion application_vendor: Mozilla 17:10:21 INFO - mozversion application_version: 48.0a1 17:10:21 INFO - mozversion platform_buildid: 20160310150717 17:10:21 INFO - mozversion platform_changeset: c1d6cd4595a03608cf23c1a6c136ea862dc37fc9 17:10:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:10:21 INFO - mozversion platform_version: 48.0a1 17:10:21 INFO - using testdate: 1457658621 17:10:21 INFO - actual date: 1457658621 17:10:21 INFO - starting webserver on 'localhost:49376' 17:10:21 INFO - SUITE-START | Running 2 tests 17:10:21 INFO - TEST-START | dromaeo_css 17:10:21 INFO - operating with platform_type : mac_ 17:10:21 INFO - Initialising browser for dromaeo_css test... 17:10:21 INFO - TEST-INFO | started process 2012 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmp3ZX4mK/profile http://localhost:49376/getInfo.html) 17:10:24 INFO - PROCESS | 2012 | __metrics Screen width/height:1600/1200 17:10:24 INFO - PROCESS | 2012 | colorDepth:24 17:10:24 INFO - PROCESS | 2012 | Browser inner width/height: 1024/689 17:10:24 INFO - PROCESS | 2012 | __metrics 17:10:24 ERROR - PROCESS | 2012 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 17:10:24 INFO - TEST-INFO | 2012: exit 0 17:10:24 INFO - Browser initialized. 17:10:24 INFO - Running cycle 1/1 for dromaeo_css test... 17:10:24 INFO - TEST-INFO | started process 2016 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmp3ZX4mK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:36 INFO - PROCESS | 2016 | RSS: Main: 255401984 17:10:36 INFO - PROCESS | 2016 | 17:11:26 INFO - PROCESS | 2016 | 1457658686489 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] 17:13:37 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49376/tests/dromaeo/cssquery-ext.html) 17:13:39 INFO - PROCESS | 2016 | RSS: Main: 270495744 17:13:39 INFO - PROCESS | 2016 | 17:16:41 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-ext.html (next: http://localhost:49376/tests/dromaeo/cssquery-jquery.html) 17:16:41 INFO - PROCESS | 2016 | RSS: Main: 283271168 17:16:41 INFO - PROCESS | 2016 | 17:19:43 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49376/tests/dromaeo/cssquery-mootools.html) 17:19:43 INFO - PROCESS | 2016 | RSS: Main: 284409856 17:19:43 INFO - PROCESS | 2016 | 17:22:45 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49376/tests/dromaeo/cssquery-prototype.html) 17:22:46 INFO - PROCESS | 2016 | RSS: Main: 284905472 17:22:46 INFO - PROCESS | 2016 | 17:25:48 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49376/tests/dromaeo/cssquery-yui.html) 17:25:49 INFO - PROCESS | 2016 | RSS: Main: 289533952 17:25:49 INFO - PROCESS | 2016 | 17:28:51 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-yui.html (next: http://localhost:49376/tests/dromaeo/cssquery-dojo.html) 17:28:52 INFO - PROCESS | 2016 | RSS: Main: 290680832 17:28:52 INFO - PROCESS | 2016 | 17:28:52 INFO - PROCESS | 2016 | __start_tp_report 17:28:52 INFO - PROCESS | 2016 | _x_x_mozilla_page_load 17:28:52 INFO - PROCESS | 2016 | _x_x_mozilla_page_load_details 17:28:52 INFO - PROCESS | 2016 | |i|pagename|runs| 17:28:52 INFO - PROCESS | 2016 | |0;dojo.html;2806.761425278851;3494.3011397720456;3539.5221645077913;3563.732720045997;3585.354636165491;5719.28508936383;5823.184754134414;5843.035899076653;5870.943230218559;5917.43784340488;5633.943660563393;5802.12968054792;5809.6804675742815;5925.940740592593;5948.643081415118;5203.037438073969;5234.869128271805;5268.394134674523;5274.472552744734;5350.625456218067;5300.681959082448;5313.9734301328635;5330.147176451768;5337.4662533746505;5337.572994160458;5110.131277682803;5146.819861304855;5227.790888364499;5229.843104706865;5250.107481728115;5223.6343455958095;5273.6572122811895;5290.470952904717;5313.654612450178;5348.91976620351;5056.519630635084;5158.432572417031;5237.554807841338;5252.343457067866;5270.525652691238;4531.342955271467;5734.139879018139;5757.107648314518;5783.21926539916;5827.388124246935;6183.165272688175;6239.970404883189;6242.781502647385;6252.499800015988;6255.186825712628;6150.907736383958;6179.752809887599;6221.191245138103;6225.501959843247;6227.657478838662;5886;5899.439553242478;5918.141869428909;5918.99377105893;5962.07587823888;6278.30938596754;6297.275813281532;6300.653464059429;6302.464290535264;6311.116443697886;6094.421030002231;6122.265328160649;6173.629582224991;6181.629102253879;6236.532260080512;5160.819371321985;6122.1542093545395;6139.84650383744;6212.285587157445;6231.283402408781;5651.406602306781;5999.340072592011;6205.751769929152;6232.189815323979;6233.875322493524;6125.510168486406;6149.7847575334645;6171.382861713792;6257.78097766576;6262.749490020348;4926.261060840831;4956.925646115239;4960.305557221992;4982.6512144149565;4988.476209997971;4458.643308535309;4461.866144015685;4475.194464996267;4481.439820022497;4491.101779644085;5446.782128714886;5911.586188966731;5942.821715348547;5972.402759723993;6059.697015149225;5069.847904562869;5226.372835259717;6179.443850053517;6212.1303017577575;6220.906686399708;5793.594448388657;5964.1650168976375;5965.433283838029;5967.313758917693;5971.4327138921735;5361.490658387447;5407.188921661782;5433.565314774809;5440.945590544123;5469.972650136724;6323.20959880015;6387.616742995435;6391.328910464427;6400.871982560416;6416.262129855127;5073.568746656576;5770.596058275881;6145.709401025834;6247.2815626201755;6256.249250090018;6173.290071641819;6227.470664993345;6231.40801623845;6241.96879015602;6262.34245404226;6036.607620504653;6054.848628784315;6087.786927457695;6094.085887116968;6120.8775824484155;6155.47678447337;6160.661163636043;6167.84580385494;6194.008958566607;6236.750529978932;5964.8807023860145;6127.9837278401355;6200.56596038273;6209.192804935329;6248.593841400295;6051.636901785907;6154.661493617715;6190.969045154746;6228.314885362697;6233.875322493615;5846.356900741001;5954.851128721816;6105.725242364193;6106.816795496142;6119.4798442132915;6146.661933593696;6161.168242287413;6164.7842325518395;6168.814935551761;6171.321154673072;6003.369646187088;6032.849178770566;6054.8183554493435;6059.151718759465;6086.239220097488 17:28:52 INFO - PROCESS | 2016 | |1;ext.html;434.21623968736435;466.3191740059513;493.8444390017144;501.3106977905379;561.9044762390394;37979.24041519168;38514.80742596286;38537;38541.614583854156;38599.80700096495;41509.37735933956;41852.58147418525;42151.78924105375;42249.52126675567;42456.36315455271;9612.951935240313;9849.606015759397;9850.014998500164;9867.802643947116;9879.259055570825;9664.081912218327;9715.659951901685;9840.311178217527;9869.95065024674;9887.505624718771;9777.46223957682;9887.752806179868;9900.653477128302;9936.304458687895;9939.900600994006;9770.560324785367;9830.803383932318;9842.557084931195;9859.50702464874;9865.90134098657;9588.808223835484;9674.08096230857;9696.563654635558;9721.076497732704;9811.362261452983;38507.614923850684;38940.415893761616;39095;39121.413178802344;39395.40906886399;2663.3208531824453;3202.551642769991;3264.755143364257;3326;3485.8082805445692;23538;28883.855580721964;28979.130626081253;29006.564901526493;29086.27284317888;2682.6512553368134;2737.767289780371;2743.3827388837553;2793.7345952134515;2873.5258682317394;493729;507741;507894;509204;511319;66983.66508167525;67626;67735.66132169307;67794.3220567788;67920.66039669869;72750.18124546822;75320.62339688267;75481.62259188668;75851.62074189594;75899.62050189824;16730.581735456468;16763.49709508717;16954.321827127023;16955.576110597332;17010.574735631708;12259.69350766238;12659.987201023896;12723;12727.872721272668;12735.617931462071;21690;21978;22059.558808824055;22071.33785986391;22797.544049118926;8269.62786674601;9432.90567094334;9714.90285097154;9717.805643887083;9735.805283894424;841.8568843296532;916.6929078758557;933.4026223217011;1001.329109496639;1072.6460268111505;26040.609390859154;29464.55803162954;29552.261193470335;30160;30241.243968900515;1017.7306200489026;1118.9440527973568;1206;1216.9959783178913;1232.3345393487596;11034.337939723642;11327;14982.026168299244;15045.849541504664;15474.071555706469;536616;543685;546468;558635.4136458583;560449;60034.69982650059;60427.09359359613;60485.39514604797;60983.6950815252;61502;1459.766437370037;1467.1930438259128;1495.4915328788047;1498.063710181115;1506.0812904128472;29254.7074529252;29322.56016159802;29362.853185733933;29976.850115749283;30100.84949575238;52395.21407178819;52866.73566632142;52872.471275286756;52890;52907.735461322445;429857;438615;441472.755817326;447111;449611;33928.15179620529;33939.66060339464;34257.82871085629;34461.310773784884;45992.54007460016;46017;46610.834729130685;47130.764346178046;47765.04469910652;48098.79753006063;34170.14574635654;39554;39627.80186099051;39677.80161099176;40267.798661006505;29670;32996.83501582477;38505.42241866318;38999.22001559896;39555.80222098871;38606;38876.80561597174;39368.212635747695;39383.89472221689;40343.19313613653;33763.55393299639;34710;35185.07408962696;35208.64791352054;35310.82344588363;25863.482730345662;26083.478330432907;26178;26313.342166445993;26525.33686657849 17:28:52 INFO - PROCESS | 2016 | |2;jquery.html;342.6231145739686;353.4133338657827;362.65185421994886;370.1763576043304;372.46179270953485;19473.318433854816;19974.50063748407;20593.38219853403;20640.793592064074;20916.16335346586;15555;18455;19830.702539461883;20421.897890510565;20559.38321850343;4982.900341993158;5653.1237658162945;5923.763049478016;5997.130416089664;6014.879702405971;5641.661500309974;5832.475077243047;5867.11993201019;5964.701764911759;6000.33996260411;5048.343715317022;5886.499647529965;5916.970415147918;5956.612820166697;5983.611065280743;4845.563899249067;5607.859803504904;5785.768569257225;5930.525557955353;5935.28776546815;4940.258961155855;5015.172496538104;5039.44566097729;5063.746812659352;5084.949150508522;24402.633960490606;25347.493050138895;25498.74501254982;25581.23256302314;26078.217653470427;2102.3377636044597;2106.3575609439113;2108.492041038173;2138.550904310097;2208.6797414374987;11865.881341186563;14628;14712.92643536786;15043.247837608185;15217.467388641344;1787.2314904591021;1795.8922464652162;1808;1808.7015642418985;1833.51411875853;94823;95090.52454737751;95615;97043.02956970481;98597;9678.516074196403;10187.9490602548;10415.791684166274;10521.84217236742;11063.451116843647;12933.482660693655;12969.092163548461;12990.805137922938;13030.869691303154;13044.282564458856;7050.400715939202;8403.747887563382;8632.870506942401;8648.005479369827;8656.48061116335;8803.251723603566;8894.86657700135;8906.910930890737;8915.687950921687;8959.776005599782;6320.968395158086;6372.490200783926;6402.8719425611225;6407.167068281094;6479.6760161991715;1679.7066258980517;1729.9308027679003;1825.5344887053716;1856.5822689894935;1858.27527264367;911.8541033434618;949.4730424614268;978.0952618827556;1013.3869009249298;1018.7860549284585;17124.9284095721;17928.462146135636;18777;19672.508187295145;20314.78111313326;910.5037754423855;934.6027938126269;950.6910254167424;951.372094417681;977.8142152990908;11008.4588157658;11124.332540047622;11159.832602510969;11216;11224.438778061227;615024;660163;665274;665952.7237820963;682528;75009;75740.86388704173;77358;112691.4365428184;115917;992.4144754594679;1021.126936469308;1037.5486663301488;1037.6316407675317;1037.8443233515034;13027.76236257554;14734.115953042852;14828.332725027616;17274.568135796704;17487.38794142199;43146.723454457446;51894.96210075853;52405;52477.7376113117;52483.950320992604;76449.47101058059;76576.23423765691;76618;78717;79642.20357796348;7740.92259077402;8030.478018928751;8087.150849160754;8137.02355717294;8169.918300816916;10681.626143084955;12464.314462704639;13000.219986800823;13115.803262951255;13568.457261709422;9011.738356629947;10685.893141068489;11171.441427928408;11234.887651123385;11503.309801411608;11053.944730276296;11070.28043177191;11149.442527873412;11154.498047587716;11410.915962983503;11582.6525204244;11618.70953226176;11666;11819.763604728028;11847.289162650268;5850.473457388855;7905.802354941173;8113.432059755761;8202.425830192067;8251.092379838334;8554.828903422022;10796.406197659204;11728.977797757367;11882.989036468525;11937 17:28:52 INFO - PROCESS | 2016 | |3;mootools.html;1437.094630382859;1535.5623647260534;1777.7955535113458;1926.9132889020002;1939.7187407825875;7964.203579642033;8308.70919517817;8774.517401542913;8907;8910.019897811244;8620.224179823814;8650.221480066793;8714.128587141282;8720.084391138935;8739.257163141125;2488.614264788956;2507.8746062696882;2523.5331463679186;2527.4313279512053;2528.645989561463;2169.511859831541;2490.9377265568323;2545.643609894616;2557.8465292082533;2558.334832943439;2495.4510007798253;2498.5002999400194;2521.155412936659;2533.5692932201478;2538.708048574419;2315.4674424882287;2315.78000089992;2329.743728189898;2341.9297421077395;2353.1646265575732;2168.991418990177;2525.5832787590025;2541.4917016596755;2564.7691707746394;2567.6662033935654;8770.824583508358;8776.254018408443;8791.428557143765;8823;8832.602532886036;5355.143177091685;5426.647267927572;5431.266778984826;5534.391216966131;5559.193916882029;3558.3417067842533;3637.636236376368;3651.5618125824803;3680.834362453696;3693.279810436966;1023.923205759571;1055.4406164732704;1057.1595581512715;1058.7194393485731;1058.8570542976754;9578;11570.595029174023;11818.231814932002;11920.403979800974;12101.939490302491;4557.521460246693;4913.164761990471;4953.455119936804;5048.949510504922;5078.97460512695;7608.619569021526;9189.954050229706;9772.827260728758;10238.590456381662;10369.9481502592;5452.482014208644;5486.670799752028;5515.090010148361;5518.972405137949;5547.861303467364;4373.059792144704;4463.018136010072;4560.8175672973375;4785.186518291899;4979.2033274676605;3312.271300313927;3491.720662347006;3858.151206734514;4052.9392059119136;4075.042365044212;1333.293354522105;1360.3266383140408;1364.5087768403366;1369.801468642834;1373.1898180073604;1343.818584491081;1373.7115205806692;1377.8966577506726;1386.5840247925582;1387.5629176809273;7965;7990.04119505663;8036.83926321482;8069.959650201711;8167.673293068329;513.9948600514022;532.8907573947331;534.8769782949944;540.6539814518711;543.9456054394528;6116.418940200763;6180.381961803873;6184.845378865564;6240.375962403814;6241.063840423973;8526.445781024213;10282.897171028344;10540.9986051325;10546.630867919586;10686.893131068746;10009.899901001043;10511;10529.789404211873;10558.260921735558;10561.735956601147;7238.624661314333;8200.015998080149;8301.29438997692;8304.418690691593;8381.622826972678;7977.960110199412;7992;8018.3585313173635;8037.075736290401;8082.555459449787;9217.44695318283;9256.53717314145;9434.575444104894;9465.621375145192;9465.763355915882;9601.663941762004;9919.40483570988;9959.701208963743;9962.103410692782;9991.750206244611;6769.559978601375;7244.710211591478;7497.362724168507;7531.8117047074265;7639.159692433716;8168.3465322772845;8209.384296177692;8257.504549727035;8258.83482330338;8259.256666900008;7249.166345870292;7339.376153027052;7367.189609142883;7495.437842161969;7516.924830751623;7270.454715896223;7303.269673032654;7323.194448610755;7351.8162045949275;7398.11222653285;7543.3965282778345;7596.126445458843;7661.923380766344;7728.536287822749;7766.068071831416;6821.147356580427;6977.232504424408;7046.330598593126;7060.046893669494;7062.823429414306;7088.397486213729;7103.041089453064;7115.6086415247655;7149.857002860018;7163.06880105583 17:28:52 INFO - PROCESS | 2016 | |4;prototype.html;319.5621997862928;336.77772670037774;342.98456569454373;345.08208166277706;346.8525876502486;5479.890402191959;5548.167774833777;6789.185297764269;6844.726210951556;6898.448124150069;5557.833265002047;6091.406070418452;6092;6347.857385670577;6685.565438246511;4398.538153493885;4772;4854.053459575384;4978.775955082012;4985.252212168168;4967.205247160455;4969.950300496985;4976.62675299354;4983.127952608297;4988.351514303154;4918.827841025565;4927.236278376839;4929.531694489017;4933.728644924546;4949.529794669501;4054.7972601369815;4194.958050419503;4680.134175177603;4971.751412429364;4973.378327709036;3389.3560223557447;3550.928981420357;3605.56733192016;3828.2343531293855;4317.956820431787;6348.809660667062;6630.9668451657435;6650.2352229493745;6668.466522678174;6688.565243259172;4817.831375901862;5779.162021506858;5791.247137872092;5843.357230704619;5850.824475265749;5850.5612079094235;7270.345668889825;7274.745383911591;7280.41756659466;7282.96358518204;3832.156925476391;4631.675782695213;4686.929696054562;4688.320193571947;4689.859304220879;7619.885701714424;7714.884276735854;7719.729809456699;7724.725420305643;7736.110347310075;4485.349624304457;4517.932231016537;4735.289706544046;4760.119377915097;4765.0946320199055;4776.785044672929;4813.109574728616;4816.8795780105775;4825.734584597881;4845.563899249014;5334.973325133349;5504.2294078829;5794.913076303858;5794.956907756644;5816.243888294579;7327.2672732726305;7330.157031941289;7330.96334518324;7348.338649521462;7356.852862942711;1420.4247279851677;1608.228050535726;1623.9756403653955;1626.414490783317;1636.7626694129285;1033.4419413516766;1069.3316677076828;1072.340510585984;1076.2251179150999;1090.5038207615517;6750.662466876636;6825.419839313615;6854.177498700188;6858;6894.586324820427;7516.323530882247;7534.246575342422;7544.660490277951;7564.562733080697;7586.734464293723;6562.80311590653;6779.491538134561;6905.274946130584;6911.3779759821855;6925.168979722465;3437.8796742114405;4010.2981978153707;4041.9797901010306;4046.393041043867;4050.5746896576024;7988.281054705104;7999;8012;8031.156728543536;8036.598170091589;6311.990081586924;7601.239876012354;7866.842663146705;7877.645505952246;7901.446898717035;8079.717209897625;8085.312748416451;8086.948696669396;8101.6354264058255;8102.473339232931;7667.3099421052375;7688.769336919901;7691.88462173079;7719.266669666373;7728;6131.478824299985;7539.359154471931;7558.281963213486;7566.35685966677;7570.545767253982;7713.575753333621;8047.195280471906;8053.959730201546;8119.79700507492;8129;4893.339399181065;4935.629827763004;4949.133901567139;4949.901001980013;4968.155413579772;7448.776536703907;7454.552726836408;7456.739014134696;7463;7482.625868706652;7276.927230727837;7298.4891057625455;7308.671109800178;7311.41508679315;7315.926840731525;5979.372165922516;7344.008558844487;7351.632418378953;7357.963210183915;7393.963030184815;7162.462815288978;7162.498625096402;7194.784156475314;7199.640017998974;7206.89189662166;5899.970500147472;7312.670929808065;7333.963330183315;7341.669624866787;7374;5501.367342755474;7141.9642901785155;7142.392896603847;7176.246494118042;7180.210176880434 17:28:52 INFO - PROCESS | 2016 | |5;yui.html;746.5781833264209;754.3286475037214;761.4137114421895;782.9686812527499;783.2480818414322;14711.558653240407;14943.701125977474;14995.775063374058;15051.548453546397;15106.471273505429;13906.374213160407;13907.930460347709;13992.79010814836;14214.289285535733;14219.289035548207;773.4083426178978;945.1493655709847;949.9952500237524;958.8897276813186;968.099667309402;958.520739630185;962.8651988721584;963.4123184857232;964.2093483343662;965.242284806427;955.1976339874504;959.4579062829514;960.9663661771839;1008.0473952115254;1012.7113772574818;955.5795450002047;1001.7295330260825;1002.5989604158322;1005.7234260578326;1006.1648831469862;619.3342157181004;712.4763298975249;732.1945859554447;752.3529764402609;753.0737193252276;14890.181040042793;14924.62688432787;14963.850361496354;15021.924890375587;15055.623609409742;12154.270743755404;12565.434555445026;12576.182548134342;12605.873941260654;12772.872271277261;9807.215422766161;9971.202303815677;10002;10042.69871903844;10327.79344413115;3323.4516304809677;3500.3524347995703;3532.2405682778067;3582.5676892388774;3627.5102861113673;73308.90036649455;73411.89882151772;73569.63215183944;73647.26352736457;75963.86054209137;9375.573511103192;9381.29640276982;9421.152096311227;9552.092551207763;9617.374870633386;21049.473763156042;21503.569928601653;21636;21649.35051948444;21681.34955951324;7242.601656908921;7302.780916572511;7393.926060739432;7547.433942454228;7555.433342499335;4067.491563554556;4119.814608342572;4122.876313710533;4130.834766609302;4139.875803725893;3293.1108600677685;3449.9995001449297;3480.164760457472;3492.1793378556017;3499.825008749552;603.3272900715758;635.3773302163905;642.3351830855042;648.3386945315846;653.1378580273993;484.2373759515367;547.5975158258756;572.7365411910484;603.9129566779867;613.8066509049635;7617.6572054257695;7897.842043159219;8018.158093400109;8045.798855028554;8226;541.748087139482;575.2234483447396;610.8198081565948;616.1035693066577;622.3247776162824;3616.8553257869917;3790.905227369338;3805;3836.55879573847;3842.8462861485227;76662.61668691621;78448;78508;78842;78983.21016789759;66720.6663966677;67450.98823517651;70853;71658.64170679114;73010.63494682492;52445.951080978164;62889.68555157195;63333;63587.36412635907;65433.67283163554;8332.625031873702;8352;8439.620217090123;8495.617697203517;8559.57202139903;43820.3141319594;46060;46119.538804612865;46318.76840615775;47066.823329417035;53948;57349;59244.33400497074;60049;62231;9138.588763505526;9706.611735530782;10092.444915529422;10695.518701658288;11013.218050573818;11689.298642081503;11708.414579271173;11721.179517433698;11722.765544688888;11759.235649682743;10864.565417383215;10868.782624347627;10905.291156074829;10995.505202266077;11727.237729547553;10982;11126.109911206922;11441.027512661183;11656.708582285512;12039.518419263131;10901.182411319025;10934.835977460503;11009.834852477059;11286.266392684449;11367.616779539148;8552.957235213784;9413.199878010446;9513;9531.284368813403;9566.091221333962;8705.390622656354;9186.632534698538;9271.76820579491;9292.442453452815;9294.674686386215 17:28:52 INFO - PROCESS | 2016 | __end_tp_report 17:28:52 INFO - PROCESS | 2016 | __start_cc_report 17:28:52 INFO - PROCESS | 2016 | _x_x_mozilla_cycle_collect,368 17:28:52 INFO - PROCESS | 2016 | __end_cc_report 17:28:52 INFO - PROCESS | 2016 | __startTimestamp1457659732050__endTimestamp 17:28:52 INFO - PROCESS | 2016 | 17:28:52 INFO - PROCESS | 2016 | ------- Summary: start ------- 17:28:52 INFO - PROCESS | 2016 | Number of tests: 6 17:28:52 INFO - PROCESS | 2016 | 17:28:52 INFO - PROCESS | 2016 | [#0] dojo.html Cycles:165 Average:5747.44 Median:5972.40 stddev:636.63 (10.7%) stddev-sans-first:595.33 17:28:52 INFO - PROCESS | 2016 | Values: 2806.8 3494.3 3539.5 3563.7 3585.4 5719.3 5823.2 5843.0 5870.9 5917.4 5633.9 5802.1 5809.7 5925.9 5948.6 5203.0 5234.9 5268.4 5274.5 5350.6 5300.7 5314.0 5330.1 5337.5 5337.6 5110.1 5146.8 5227.8 5229.8 5250.1 5223.6 5273.7 5290.5 5313.7 5348.9 5056.5 5158.4 5237.6 5252.3 5270.5 4531.3 5734.1 5757.1 5783.2 5827.4 6183.2 6240.0 6242.8 6252.5 6255.2 6150.9 6179.8 6221.2 6225.5 6227.7 5886.0 5899.4 5918.1 5919.0 5962.1 6278.3 6297.3 6300.7 6302.5 6311.1 6094.4 6122.3 6173.6 6181.6 6236.5 5160.8 6122.2 6139.8 6212.3 6231.3 5651.4 5999.3 6205.8 6232.2 6233.9 6125.5 6149.8 6171.4 6257.8 6262.7 4926.3 4956.9 4960.3 4982.7 4988.5 4458.6 4461.9 4475.2 4481.4 4491.1 5446.8 5911.6 5942.8 5972.4 6059.7 5069.8 5226.4 6179.4 6212.1 6220.9 5793.6 5964.2 5965.4 5967.3 5971.4 5361.5 5407.2 5433.6 5440.9 5470.0 6323.2 6387.6 6391.3 6400.9 6416.3 5073.6 5770.6 6145.7 6247.3 6256.2 6173.3 6227.5 6231.4 6242.0 6262.3 6036.6 6054.8 6087.8 6094.1 6120.9 6155.5 6160.7 6167.8 6194.0 6236.8 5964.9 6128.0 6200.6 6209.2 6248.6 6051.6 6154.7 6191.0 6228.3 6233.9 5846.4 5954.9 6105.7 6106.8 6119.5 6146.7 6161.2 6164.8 6168.8 6171.3 6003.4 6032.8 6054.8 6059.2 6086.2 17:28:52 INFO - PROCESS | 2016 | 17:28:52 INFO - PROCESS | 2016 | [#1] ext.html Cycles:180 Average:65303.96 Median:39554.90 stddev:133131.21 (336.6%) stddev-sans-first:133415.59 17:28:52 INFO - PROCESS | 2016 | Values: 434.2 466.3 493.8 501.3 561.9 37979.2 38514.8 38537.0 38541.6 38599.8 41509.4 41852.6 42151.8 42249.5 42456.4 9613.0 9849.6 9850.0 9867.8 9879.3 9664.1 9715.7 9840.3 9870.0 9887.5 9777.5 9887.8 9900.7 9936.3 9939.9 9770.6 9830.8 9842.6 9859.5 9865.9 9588.8 9674.1 9696.6 9721.1 9811.4 38507.6 38940.4 39095.0 39121.4 39395.4 2663.3 3202.6 3264.8 3326.0 3485.8 23538.0 28883.9 28979.1 29006.6 29086.3 2682.7 2737.8 2743.4 2793.7 2873.5 493729.0 507741.0 507894.0 509204.0 511319.0 66983.7 67626.0 67735.7 67794.3 67920.7 72750.2 75320.6 75481.6 75851.6 75899.6 16730.6 16763.5 16954.3 16955.6 17010.6 12259.7 12660.0 12723.0 12727.9 12735.6 21690.0 21978.0 22059.6 22071.3 22797.5 8269.6 9432.9 9714.9 9717.8 9735.8 841.9 916.7 933.4 1001.3 1072.6 26040.6 29464.6 29552.3 30160.0 30241.2 1017.7 1118.9 1206.0 1217.0 1232.3 11034.3 11327.0 14982.0 15045.8 15474.1 536616.0 543685.0 546468.0 558635.4 560449.0 60034.7 60427.1 60485.4 60983.7 61502.0 1459.8 1467.2 1495.5 1498.1 1506.1 29254.7 29322.6 29362.9 29976.9 30100.8 52395.2 52866.7 52872.5 52890.0 52907.7 429857.0 438615.0 441472.8 447111.0 449611.0 33928.2 33939.7 34257.8 34461.3 45992.5 46017.0 46610.8 47130.8 47765.0 48098.8 34170.1 39554.0 39627.8 39677.8 40267.8 29670.0 32996.8 38505.4 38999.2 39555.8 38606.0 38876.8 39368.2 39383.9 40343.2 33763.6 34710.0 35185.1 35208.6 35310.8 25863.5 26083.5 26178.0 26313.3 26525.3 17:28:52 INFO - PROCESS | 2016 | 17:28:52 INFO - PROCESS | 2016 | [#2] jquery.html Cycles:180 Average:34849.55 Median:348.02 stddev:108286.45 (31115.2%) stddev-sans-first:108559.22 17:28:52 INFO - PROCESS | 2016 | Values: 342.6 353.4 362.7 370.2 372.5 19473.3 19974.5 20593.4 20640.8 20916.2 15555.0 18455.0 19830.7 20421.9 20559.4 4982.9 5653.1 5923.8 5997.1 6014.9 5641.7 5832.5 5867.1 5964.7 6000.3 5048.3 5886.5 5917.0 5956.6 5983.6 4845.6 5607.9 5785.8 5930.5 5935.3 4940.3 5015.2 5039.4 5063.7 5084.9 24402.6 25347.5 25498.7 25581.2 26078.2 2102.3 2106.4 2108.5 2138.6 2208.7 11865.9 14628.0 14712.9 15043.2 15217.5 1787.2 1795.9 1808.0 1808.7 1833.5 94823.0 95090.5 95615.0 97043.0 98597.0 9678.5 10187.9 10415.8 10521.8 11063.5 12933.5 12969.1 12990.8 13030.9 13044.3 7050.4 8403.7 8632.9 8648.0 8656.5 8803.3 8894.9 8906.9 8915.7 8959.8 6321.0 6372.5 6402.9 6407.2 6479.7 1679.7 1729.9 1825.5 1856.6 1858.3 911.9 949.5 978.1 1013.4 1018.8 17124.9 17928.5 18777.0 19672.5 20314.8 910.5 934.6 950.7 951.4 977.8 11008.5 11124.3 11159.8 11216.0 11224.4 615024.0 660163.0 665274.0 665952.7 682528.0 75009.0 75740.9 77358.0 112691.4 115917.0 992.4 1021.1 1037.5 1037.6 1037.8 13027.8 14734.1 14828.3 17274.6 17487.4 43146.7 51895.0 52405.0 52477.7 52484.0 76449.5 76576.2 76618.0 78717.0 79642.2 7740.9 8030.5 8087.2 8137.0 8169.9 10681.6 12464.3 13000.2 13115.8 13568.5 9011.7 10685.9 11171.4 11234.9 11503.3 11053.9 11070.3 11149.4 11154.5 11410.9 11582.7 11618.7 11666.0 11819.8 11847.3 5850.5 7905.8 8113.4 8202.4 8251.1 8554.8 10796.4 11729.0 11883.0 11937.0 17:28:52 INFO - PROCESS | 2016 | 17:28:52 INFO - PROCESS | 2016 | [#3] mootools.html Cycles:180 Average:5982.41 Median:5517.03 stddev:3124.81 (56.6%) stddev-sans-first:3114.90 17:28:52 INFO - PROCESS | 2016 | Values: 1437.1 1535.6 1777.8 1926.9 1939.7 7964.2 8308.7 8774.5 8907.0 8910.0 8620.2 8650.2 8714.1 8720.1 8739.3 2488.6 2507.9 2523.5 2527.4 2528.6 2169.5 2490.9 2545.6 2557.8 2558.3 2495.5 2498.5 2521.2 2533.6 2538.7 2315.5 2315.8 2329.7 2341.9 2353.2 2169.0 2525.6 2541.5 2564.8 2567.7 8770.8 8776.3 8791.4 8823.0 8832.6 5355.1 5426.6 5431.3 5534.4 5559.2 3558.3 3637.6 3651.6 3680.8 3693.3 1023.9 1055.4 1057.2 1058.7 1058.9 9578.0 11570.6 11818.2 11920.4 12101.9 4557.5 4913.2 4953.5 5048.9 5079.0 7608.6 9190.0 9772.8 10238.6 10369.9 5452.5 5486.7 5515.1 5519.0 5547.9 4373.1 4463.0 4560.8 4785.2 4979.2 3312.3 3491.7 3858.2 4052.9 4075.0 1333.3 1360.3 1364.5 1369.8 1373.2 1343.8 1373.7 1377.9 1386.6 1387.6 7965.0 7990.0 8036.8 8070.0 8167.7 514.0 532.9 534.9 540.7 543.9 6116.4 6180.4 6184.8 6240.4 6241.1 8526.4 10282.9 10541.0 10546.6 10686.9 10009.9 10511.0 10529.8 10558.3 10561.7 7238.6 8200.0 8301.3 8304.4 8381.6 7978.0 7992.0 8018.4 8037.1 8082.6 9217.4 9256.5 9434.6 9465.6 9465.8 9601.7 9919.4 9959.7 9962.1 9991.8 6769.6 7244.7 7497.4 7531.8 7639.2 8168.3 8209.4 8257.5 8258.8 8259.3 7249.2 7339.4 7367.2 7495.4 7516.9 7270.5 7303.3 7323.2 7351.8 7398.1 7543.4 7596.1 7661.9 7728.5 7766.1 6821.1 6977.2 7046.3 7060.0 7062.8 7088.4 7103.0 7115.6 7149.9 7163.1 17:28:52 INFO - PROCESS | 2016 | 17:28:52 INFO - PROCESS | 2016 | [#4] prototype.html Cycles:180 Average:5886.76 Median:6659.35 stddev:1964.83 (29.5%) stddev-sans-first:1925.40 17:28:52 INFO - PROCESS | 2016 | Values: 319.6 336.8 343.0 345.1 346.9 5479.9 5548.2 6789.2 6844.7 6898.4 5557.8 6091.4 6092.0 6347.9 6685.6 4398.5 4772.0 4854.1 4978.8 4985.3 4967.2 4970.0 4976.6 4983.1 4988.4 4918.8 4927.2 4929.5 4933.7 4949.5 4054.8 4195.0 4680.1 4971.8 4973.4 3389.4 3550.9 3605.6 3828.2 4318.0 6348.8 6631.0 6650.2 6668.5 6688.6 4817.8 5779.2 5791.2 5843.4 5850.8 5850.6 7270.3 7274.7 7280.4 7283.0 3832.2 4631.7 4686.9 4688.3 4689.9 7619.9 7714.9 7719.7 7724.7 7736.1 4485.3 4517.9 4735.3 4760.1 4765.1 4776.8 4813.1 4816.9 4825.7 4845.6 5335.0 5504.2 5794.9 5795.0 5816.2 7327.3 7330.2 7331.0 7348.3 7356.9 1420.4 1608.2 1624.0 1626.4 1636.8 1033.4 1069.3 1072.3 1076.2 1090.5 6750.7 6825.4 6854.2 6858.0 6894.6 7516.3 7534.2 7544.7 7564.6 7586.7 6562.8 6779.5 6905.3 6911.4 6925.2 3437.9 4010.3 4042.0 4046.4 4050.6 7988.3 7999.0 8012.0 8031.2 8036.6 6312.0 7601.2 7866.8 7877.6 7901.4 8079.7 8085.3 8086.9 8101.6 8102.5 7667.3 7688.8 7691.9 7719.3 7728.0 6131.5 7539.4 7558.3 7566.4 7570.5 7713.6 8047.2 8054.0 8119.8 8129.0 4893.3 4935.6 4949.1 4949.9 4968.2 7448.8 7454.6 7456.7 7463.0 7482.6 7276.9 7298.5 7308.7 7311.4 7315.9 5979.4 7344.0 7351.6 7358.0 7394.0 7162.5 7162.5 7194.8 7199.6 7206.9 5900.0 7312.7 7334.0 7341.7 7374.0 5501.4 7142.0 7142.4 7176.2 7180.2 17:28:52 INFO - PROCESS | 2016 | 17:28:52 INFO - PROCESS | 2016 | [#5] yui.html Cycles:180 Average:16817.47 Median:59646.67 stddev:22526.07 (37.8%) stddev-sans-first:22556.94 17:28:52 INFO - PROCESS | 2016 | Values: 746.6 754.3 761.4 783.0 783.2 14711.6 14943.7 14995.8 15051.5 15106.5 13906.4 13907.9 13992.8 14214.3 14219.3 773.4 945.1 950.0 958.9 968.1 958.5 962.9 963.4 964.2 965.2 955.2 959.5 961.0 1008.0 1012.7 955.6 1001.7 1002.6 1005.7 1006.2 619.3 712.5 732.2 752.4 753.1 14890.2 14924.6 14963.9 15021.9 15055.6 12154.3 12565.4 12576.2 12605.9 12772.9 9807.2 9971.2 10002.0 10042.7 10327.8 3323.5 3500.4 3532.2 3582.6 3627.5 73308.9 73411.9 73569.6 73647.3 75963.9 9375.6 9381.3 9421.2 9552.1 9617.4 21049.5 21503.6 21636.0 21649.4 21681.3 7242.6 7302.8 7393.9 7547.4 7555.4 4067.5 4119.8 4122.9 4130.8 4139.9 3293.1 3450.0 3480.2 3492.2 3499.8 603.3 635.4 642.3 648.3 653.1 484.2 547.6 572.7 603.9 613.8 7617.7 7897.8 8018.2 8045.8 8226.0 541.7 575.2 610.8 616.1 622.3 3616.9 3790.9 3805.0 3836.6 3842.8 76662.6 78448.0 78508.0 78842.0 78983.2 66720.7 67451.0 70853.0 71658.6 73010.6 52446.0 62889.7 63333.0 63587.4 65433.7 8332.6 8352.0 8439.6 8495.6 8559.6 43820.3 46060.0 46119.5 46318.8 47066.8 53948.0 57349.0 59244.3 60049.0 62231.0 9138.6 9706.6 10092.4 10695.5 11013.2 11689.3 11708.4 11721.2 11722.8 11759.2 10864.6 10868.8 10905.3 10995.5 11727.2 10982.0 11126.1 11441.0 11656.7 12039.5 10901.2 10934.8 11009.8 11286.3 11367.6 8553.0 9413.2 9513.0 9531.3 9566.1 8705.4 9186.6 9271.8 9292.4 9294.7 17:28:52 INFO - PROCESS | 2016 | -------- Summary: end -------- 17:28:52 INFO - PROCESS | 2016 | 17:28:52 INFO - TEST-INFO | 2016: exit 0 17:28:52 INFO - TEST-OK | dromaeo_css | took 1111093ms 17:28:52 INFO - TEST-START | kraken 17:28:52 INFO - operating with platform_type : mac_ 17:28:52 INFO - Initialising browser for kraken test... 17:28:52 INFO - TEST-INFO | started process 2021 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpmLeEUR/profile http://localhost:49376/getInfo.html) 17:28:55 INFO - PROCESS | 2021 | __metrics Screen width/height:1600/1200 17:28:55 INFO - PROCESS | 2021 | colorDepth:24 17:28:55 INFO - PROCESS | 2021 | Browser inner width/height: 1024/689 17:28:55 INFO - PROCESS | 2021 | __metrics 17:28:55 ERROR - PROCESS | 2021 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 17:28:56 INFO - TEST-INFO | 2021: exit 0 17:28:56 INFO - Browser initialized. 17:28:56 INFO - Running cycle 1/1 for kraken test... 17:28:56 INFO - TEST-INFO | started process 2024 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpmLeEUR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:08 INFO - PROCESS | 2024 | RSS: Main: 255311872 17:29:08 INFO - PROCESS | 2024 | 17:29:10 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-beat-detection) 17:29:11 INFO - PROCESS | 2024 | RSS: Main: 269152256 17:29:11 INFO - PROCESS | 2024 | 17:29:14 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-dft) 17:29:14 INFO - PROCESS | 2024 | RSS: Main: 276287488 17:29:14 INFO - PROCESS | 2024 | 17:29:18 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-fft) 17:29:18 INFO - PROCESS | 2024 | RSS: Main: 281051136 17:29:18 INFO - PROCESS | 2024 | 17:29:20 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-oscillator) 17:29:21 INFO - PROCESS | 2024 | RSS: Main: 280272896 17:29:21 INFO - PROCESS | 2024 | 17:29:23 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:29:23 INFO - PROCESS | 2024 | RSS: Main: 282091520 17:29:23 INFO - PROCESS | 2024 | 17:29:26 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-darkroom) 17:29:27 INFO - PROCESS | 2024 | RSS: Main: 283738112 17:29:27 INFO - PROCESS | 2024 | 17:29:30 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-desaturate) 17:29:30 INFO - PROCESS | 2024 | RSS: Main: 284237824 17:29:30 INFO - PROCESS | 2024 | 17:29:33 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49376/tests/kraken/driver.html?testName=json-parse-financial) 17:29:34 INFO - PROCESS | 2024 | RSS: Main: 283832320 17:29:34 INFO - PROCESS | 2024 | 17:29:35 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:29:36 INFO - PROCESS | 2024 | RSS: Main: 284688384 17:29:36 INFO - PROCESS | 2024 | 17:29:38 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:29:38 INFO - PROCESS | 2024 | RSS: Main: 282886144 17:29:38 INFO - PROCESS | 2024 | 17:29:40 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:29:41 INFO - PROCESS | 2024 | RSS: Main: 283607040 17:29:41 INFO - PROCESS | 2024 | 17:29:44 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:29:44 INFO - PROCESS | 2024 | RSS: Main: 282542080 17:29:44 INFO - PROCESS | 2024 | 17:29:47 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:29:48 INFO - PROCESS | 2024 | RSS: Main: 284012544 17:29:48 INFO - PROCESS | 2024 | 17:29:49 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49376/tests/kraken/driver.html?testName=ai-astar) 17:29:50 INFO - PROCESS | 2024 | RSS: Main: 284430336 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | __start_tp_report 17:29:50 INFO - PROCESS | 2024 | _x_x_mozilla_page_load 17:29:50 INFO - PROCESS | 2024 | _x_x_mozilla_page_load_details 17:29:50 INFO - PROCESS | 2024 | |i|pagename|runs| 17:29:50 INFO - PROCESS | 2024 | |0;ai-astar;115;110;115;115;115;130;114;115;118;116 17:29:50 INFO - PROCESS | 2024 | |1;audio-beat-detection;156;117;145;156;121;144;145;124;158;123 17:29:50 INFO - PROCESS | 2024 | |2;audio-dft;193;197;198;202;221;215;268;280;199;205 17:29:50 INFO - PROCESS | 2024 | |3;audio-fft;72;72;75;149;57;57;57;62;96;57 17:29:50 INFO - PROCESS | 2024 | |4;audio-oscillator;83;81;123;77;83;80;120;80;79;123 17:29:50 INFO - PROCESS | 2024 | |5;imaging-gaussian-blur;88;87;88;86;82;124;89;86;89;97 17:29:50 INFO - PROCESS | 2024 | |6;imaging-darkroom;94;96;95;94;95;94;93;108;120;92 17:29:50 INFO - PROCESS | 2024 | |7;imaging-desaturate;121;149;116;92;92;90;93;92;94;94 17:29:50 INFO - PROCESS | 2024 | |8;json-parse-financial;54;56;55;57;55;59;55;61;62;67 17:29:50 INFO - PROCESS | 2024 | |9;json-stringify-tinderbox;69;67;72;76;67;67;68;68;71;73 17:29:50 INFO - PROCESS | 2024 | |10;stanford-crypto-aes;87;83;87;85;86;84;87;87;85;85 17:29:50 INFO - PROCESS | 2024 | |11;stanford-crypto-ccm;130;125;142;135;121;123;132;136;122;127 17:29:50 INFO - PROCESS | 2024 | |12;stanford-crypto-pbkdf2;160;178;180;141;137;130;141;140;140;131 17:29:50 INFO - PROCESS | 2024 | |13;stanford-crypto-sha256-iterative;71;76;101;95;100;95;97;80;70;67 17:29:50 INFO - PROCESS | 2024 | __end_tp_report 17:29:50 INFO - PROCESS | 2024 | __start_cc_report 17:29:50 INFO - PROCESS | 2024 | _x_x_mozilla_cycle_collect,931 17:29:50 INFO - PROCESS | 2024 | __end_cc_report 17:29:50 INFO - PROCESS | 2024 | __startTimestamp1457659790153__endTimestamp 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | ------- Summary: start ------- 17:29:50 INFO - PROCESS | 2024 | Number of tests: 14 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | [#0] ai-astar Cycles:10 Average:116.30 Median:115.00 stddev:5.21 (4.5%) stddev-sans-first:5.50 17:29:50 INFO - PROCESS | 2024 | Values: 115.0 110.0 115.0 115.0 115.0 130.0 114.0 115.0 118.0 116.0 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:145.00 stddev:16.07 (11.1%) stddev-sans-first:15.81 17:29:50 INFO - PROCESS | 2024 | Values: 156.0 117.0 145.0 156.0 121.0 144.0 145.0 124.0 158.0 123.0 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | [#2] audio-dft Cycles:10 Average:217.80 Median:210.00 stddev:30.94 (14.7%) stddev-sans-first:31.48 17:29:50 INFO - PROCESS | 2024 | Values: 193.0 197.0 198.0 202.0 221.0 215.0 268.0 280.0 199.0 205.0 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | [#3] audio-fft Cycles:10 Average:75.40 Median:67.00 stddev:28.67 (42.8%) stddev-sans-first:30.38 17:29:50 INFO - PROCESS | 2024 | Values: 72.0 72.0 75.0 149.0 57.0 57.0 57.0 62.0 96.0 57.0 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:80.00 stddev:20.17 (25.2%) stddev-sans-first:21.08 17:29:50 INFO - PROCESS | 2024 | Values: 83.0 81.0 123.0 77.0 83.0 80.0 120.0 80.0 79.0 123.0 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | [#5] imaging-gaussian-blur Cycles:10 Average:91.60 Median:88.00 stddev:11.99 (13.6%) stddev-sans-first:12.65 17:29:50 INFO - PROCESS | 2024 | Values: 88.0 87.0 88.0 86.0 82.0 124.0 89.0 86.0 89.0 97.0 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | [#6] imaging-darkroom Cycles:10 Average:98.10 Median:94.00 stddev:8.91 (9.5%) stddev-sans-first:9.33 17:29:50 INFO - PROCESS | 2024 | Values: 94.0 96.0 95.0 94.0 95.0 94.0 93.0 108.0 120.0 92.0 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | [#7] imaging-desaturate Cycles:10 Average:103.30 Median:92.00 stddev:19.44 (21.1%) stddev-sans-first:19.54 17:29:50 INFO - PROCESS | 2024 | Values: 121.0 149.0 116.0 92.0 92.0 90.0 93.0 92.0 94.0 94.0 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:4.15 (7.2%) stddev-sans-first:4.13 17:29:50 INFO - PROCESS | 2024 | Values: 54.0 56.0 55.0 57.0 55.0 59.0 55.0 61.0 62.0 67.0 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:3.08 (4.4%) stddev-sans-first:3.26 17:29:50 INFO - PROCESS | 2024 | Values: 69.0 67.0 72.0 76.0 67.0 67.0 68.0 68.0 71.0 73.0 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.50 stddev:1.43 (1.7%) stddev-sans-first:1.42 17:29:50 INFO - PROCESS | 2024 | Values: 87.0 83.0 87.0 85.0 86.0 84.0 87.0 87.0 85.0 85.0 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:131.00 stddev:6.93 (5.3%) stddev-sans-first:7.34 17:29:50 INFO - PROCESS | 2024 | Values: 130.0 125.0 142.0 135.0 121.0 123.0 132.0 136.0 122.0 127.0 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:141.00 stddev:18.34 (13.0%) stddev-sans-first:18.92 17:29:50 INFO - PROCESS | 2024 | Values: 160.0 178.0 180.0 141.0 137.0 130.0 141.0 140.0 140.0 131.0 17:29:50 INFO - PROCESS | 2024 | 17:29:50 INFO - PROCESS | 2024 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.20 Median:78.00 stddev:13.64 (17.5%) stddev-sans-first:13.47 17:29:50 INFO - PROCESS | 2024 | Values: 71.0 76.0 101.0 95.0 100.0 95.0 97.0 80.0 70.0 67.0 17:29:50 INFO - PROCESS | 2024 | -------- Summary: end -------- 17:29:50 INFO - PROCESS | 2024 | 17:29:51 INFO - TEST-INFO | 2024: exit 0 17:29:51 INFO - TEST-OK | kraken | took 58559ms 17:29:51 INFO - SUITE-END | took 1169s 17:29:51 INFO - Completed test suite (00:19:29) 17:29:51 INFO - javascript benchmark 17:29:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2806.761425278851, 3494.3011397720456, 3539.5221645077913, 3563.732720045997, 3585.354636165491, 5719.28508936383, 5823.184754134414, 5843.035899076653, 5870.943230218559, 5917.43784340488, 5633.943660563393, 5802.12968054792, 5809.6804675742815, 5925.940740592593, 5948.643081415118, 5203.037438073969, 5234.869128271805, 5268.394134674523, 5274.472552744734, 5350.625456218067, 5300.681959082448, 5313.9734301328635, 5330.147176451768, 5337.4662533746505, 5337.572994160458, 5110.131277682803, 5146.819861304855, 5227.790888364499, 5229.843104706865, 5250.107481728115, 5223.6343455958095, 5273.6572122811895, 5290.470952904717, 5313.654612450178, 5348.91976620351, 5056.519630635084, 5158.432572417031, 5237.554807841338, 5252.343457067866, 5270.525652691238, 4531.342955271467, 5734.139879018139, 5757.107648314518, 5783.21926539916, 5827.388124246935, 6183.165272688175, 6239.970404883189, 6242.781502647385, 6252.499800015988, 6255.186825712628, 6150.907736383958, 6179.752809887599, 6221.191245138103, 6225.501959843247, 6227.657478838662, 5886.0, 5899.439553242478, 5918.141869428909, 5918.99377105893, 5962.07587823888, 6278.30938596754, 6297.275813281532, 6300.653464059429, 6302.464290535264, 6311.116443697886, 6094.421030002231, 6122.265328160649, 6173.629582224991, 6181.629102253879, 6236.532260080512, 5160.819371321985, 6122.1542093545395, 6139.84650383744, 6212.285587157445, 6231.283402408781, 5651.406602306781, 5999.340072592011, 6205.751769929152, 6232.189815323979, 6233.875322493524, 6125.510168486406, 6149.7847575334645, 6171.382861713792, 6257.78097766576, 6262.749490020348, 4926.261060840831, 4956.925646115239, 4960.305557221992, 4982.6512144149565, 4988.476209997971, 4458.643308535309, 4461.866144015685, 4475.194464996267, 4481.439820022497, 4491.101779644085, 5446.782128714886, 5911.586188966731, 5942.821715348547, 5972.402759723993, 6059.697015149225, 5069.847904562869, 5226.372835259717, 6179.443850053517, 6212.1303017577575, 6220.906686399708, 5793.594448388657, 5964.1650168976375, 5965.433283838029, 5967.313758917693, 5971.4327138921735, 5361.490658387447, 5407.188921661782, 5433.565314774809, 5440.945590544123, 5469.972650136724, 6323.20959880015, 6387.616742995435, 6391.328910464427, 6400.871982560416, 6416.262129855127, 5073.568746656576, 5770.596058275881, 6145.709401025834, 6247.2815626201755, 6256.249250090018, 6173.290071641819, 6227.470664993345, 6231.40801623845, 6241.96879015602, 6262.34245404226, 6036.607620504653, 6054.848628784315, 6087.786927457695, 6094.085887116968, 6120.8775824484155, 6155.47678447337, 6160.661163636043, 6167.84580385494, 6194.008958566607, 6236.750529978932, 5964.8807023860145, 6127.9837278401355, 6200.56596038273, 6209.192804935329, 6248.593841400295, 6051.636901785907, 6154.661493617715, 6190.969045154746, 6228.314885362697, 6233.875322493615, 5846.356900741001, 5954.851128721816, 6105.725242364193, 6106.816795496142, 6119.4798442132915, 6146.661933593696, 6161.168242287413, 6164.7842325518395, 6168.814935551761, 6171.321154673072, 6003.369646187088, 6032.849178770566, 6054.8183554493435, 6059.151718759465, 6086.239220097488], "unit": "score", "name": "dojo.html", "value": 5709.015189091407}, {"lowerIsBetter": false, "replicates": [434.21623968736435, 466.3191740059513, 493.8444390017144, 501.3106977905379, 561.9044762390394, 37979.24041519168, 38514.80742596286, 38537.0, 38541.614583854156, 38599.80700096495, 41509.37735933956, 41852.58147418525, 42151.78924105375, 42249.52126675567, 42456.36315455271, 9612.951935240313, 9849.606015759397, 9850.014998500164, 9867.802643947116, 9879.259055570825, 9664.081912218327, 9715.659951901685, 9840.311178217527, 9869.95065024674, 9887.505624718771, 9777.46223957682, 9887.752806179868, 9900.653477128302, 9936.304458687895, 9939.900600994006, 9770.560324785367, 9830.803383932318, 9842.557084931195, 9859.50702464874, 9865.90134098657, 9588.808223835484, 9674.08096230857, 9696.563654635558, 9721.076497732704, 9811.362261452983, 38507.614923850684, 38940.415893761616, 39095.0, 39121.413178802344, 39395.40906886399, 2663.3208531824453, 3202.551642769991, 3264.755143364257, 3326.0, 3485.8082805445692, 23538.0, 28883.855580721964, 28979.130626081253, 29006.564901526493, 29086.27284317888, 2682.6512553368134, 2737.767289780371, 2743.3827388837553, 2793.7345952134515, 2873.5258682317394, 493729.0, 507741.0, 507894.0, 509204.0, 511319.0, 66983.66508167525, 67626.0, 67735.66132169307, 67794.3220567788, 67920.66039669869, 72750.18124546822, 75320.62339688267, 75481.62259188668, 75851.62074189594, 75899.62050189824, 16730.581735456468, 16763.49709508717, 16954.321827127023, 16955.576110597332, 17010.574735631708, 12259.69350766238, 12659.987201023896, 12723.0, 12727.872721272668, 12735.617931462071, 21690.0, 21978.0, 22059.558808824055, 22071.33785986391, 22797.544049118926, 8269.62786674601, 9432.90567094334, 9714.90285097154, 9717.805643887083, 9735.805283894424, 841.8568843296532, 916.6929078758557, 933.4026223217011, 1001.329109496639, 1072.6460268111505, 26040.609390859154, 29464.55803162954, 29552.261193470335, 30160.0, 30241.243968900515, 1017.7306200489026, 1118.9440527973568, 1206.0, 1216.9959783178913, 1232.3345393487596, 11034.337939723642, 11327.0, 14982.026168299244, 15045.849541504664, 15474.071555706469, 536616.0, 543685.0, 546468.0, 558635.4136458583, 560449.0, 60034.69982650059, 60427.09359359613, 60485.39514604797, 60983.6950815252, 61502.0, 1459.766437370037, 1467.1930438259128, 1495.4915328788047, 1498.063710181115, 1506.0812904128472, 29254.7074529252, 29322.56016159802, 29362.853185733933, 29976.850115749283, 30100.84949575238, 52395.21407178819, 52866.73566632142, 52872.471275286756, 52890.0, 52907.735461322445, 429857.0, 438615.0, 441472.755817326, 447111.0, 449611.0, 33928.15179620529, 33939.66060339464, 34257.82871085629, 34461.310773784884, 45992.54007460016, 46017.0, 46610.834729130685, 47130.764346178046, 47765.04469910652, 48098.79753006063, 34170.14574635654, 39554.0, 39627.80186099051, 39677.80161099176, 40267.798661006505, 29670.0, 32996.83501582477, 38505.42241866318, 38999.22001559896, 39555.80222098871, 38606.0, 38876.80561597174, 39368.212635747695, 39383.89472221689, 40343.19313613653, 33763.55393299639, 34710.0, 35185.07408962696, 35208.64791352054, 35310.82344588363, 25863.482730345662, 26083.478330432907, 26178.0, 26313.342166445993, 26525.33686657849], "unit": "score", "name": "ext.html", "value": 20212.848811652733}, {"lowerIsBetter": false, "replicates": [342.6231145739686, 353.4133338657827, 362.65185421994886, 370.1763576043304, 372.46179270953485, 19473.318433854816, 19974.50063748407, 20593.38219853403, 20640.793592064074, 20916.16335346586, 15555.0, 18455.0, 19830.702539461883, 20421.897890510565, 20559.38321850343, 4982.900341993158, 5653.1237658162945, 5923.763049478016, 5997.130416089664, 6014.879702405971, 5641.661500309974, 5832.475077243047, 5867.11993201019, 5964.701764911759, 6000.33996260411, 5048.343715317022, 5886.499647529965, 5916.970415147918, 5956.612820166697, 5983.611065280743, 4845.563899249067, 5607.859803504904, 5785.768569257225, 5930.525557955353, 5935.28776546815, 4940.258961155855, 5015.172496538104, 5039.44566097729, 5063.746812659352, 5084.949150508522, 24402.633960490606, 25347.493050138895, 25498.74501254982, 25581.23256302314, 26078.217653470427, 2102.3377636044597, 2106.3575609439113, 2108.492041038173, 2138.550904310097, 2208.6797414374987, 11865.881341186563, 14628.0, 14712.92643536786, 15043.247837608185, 15217.467388641344, 1787.2314904591021, 1795.8922464652162, 1808.0, 1808.7015642418985, 1833.51411875853, 94823.0, 95090.52454737751, 95615.0, 97043.02956970481, 98597.0, 9678.516074196403, 10187.9490602548, 10415.791684166274, 10521.84217236742, 11063.451116843647, 12933.482660693655, 12969.092163548461, 12990.805137922938, 13030.869691303154, 13044.282564458856, 7050.400715939202, 8403.747887563382, 8632.870506942401, 8648.005479369827, 8656.48061116335, 8803.251723603566, 8894.86657700135, 8906.910930890737, 8915.687950921687, 8959.776005599782, 6320.968395158086, 6372.490200783926, 6402.8719425611225, 6407.167068281094, 6479.6760161991715, 1679.7066258980517, 1729.9308027679003, 1825.5344887053716, 1856.5822689894935, 1858.27527264367, 911.8541033434618, 949.4730424614268, 978.0952618827556, 1013.3869009249298, 1018.7860549284585, 17124.9284095721, 17928.462146135636, 18777.0, 19672.508187295145, 20314.78111313326, 910.5037754423855, 934.6027938126269, 950.6910254167424, 951.372094417681, 977.8142152990908, 11008.4588157658, 11124.332540047622, 11159.832602510969, 11216.0, 11224.438778061227, 615024.0, 660163.0, 665274.0, 665952.7237820963, 682528.0, 75009.0, 75740.86388704173, 77358.0, 112691.4365428184, 115917.0, 992.4144754594679, 1021.126936469308, 1037.5486663301488, 1037.6316407675317, 1037.8443233515034, 13027.76236257554, 14734.115953042852, 14828.332725027616, 17274.568135796704, 17487.38794142199, 43146.723454457446, 51894.96210075853, 52405.0, 52477.7376113117, 52483.950320992604, 76449.47101058059, 76576.23423765691, 76618.0, 78717.0, 79642.20357796348, 7740.92259077402, 8030.478018928751, 8087.150849160754, 8137.02355717294, 8169.918300816916, 10681.626143084955, 12464.314462704639, 13000.219986800823, 13115.803262951255, 13568.457261709422, 9011.738356629947, 10685.893141068489, 11171.441427928408, 11234.887651123385, 11503.309801411608, 11053.944730276296, 11070.28043177191, 11149.442527873412, 11154.498047587716, 11410.915962983503, 11582.6525204244, 11618.70953226176, 11666.0, 11819.763604728028, 11847.289162650268, 5850.473457388855, 7905.802354941173, 8113.432059755761, 8202.425830192067, 8251.092379838334, 8554.828903422022, 10796.406197659204, 11728.977797757367, 11882.989036468525, 11937.0], "unit": "score", "name": "jquery.html", "value": 9379.633019136663}, {"lowerIsBetter": false, "replicates": [1437.094630382859, 1535.5623647260534, 1777.7955535113458, 1926.9132889020002, 1939.7187407825875, 7964.203579642033, 8308.70919517817, 8774.517401542913, 8907.0, 8910.019897811244, 8620.224179823814, 8650.221480066793, 8714.128587141282, 8720.084391138935, 8739.257163141125, 2488.614264788956, 2507.8746062696882, 2523.5331463679186, 2527.4313279512053, 2528.645989561463, 2169.511859831541, 2490.9377265568323, 2545.643609894616, 2557.8465292082533, 2558.334832943439, 2495.4510007798253, 2498.5002999400194, 2521.155412936659, 2533.5692932201478, 2538.708048574419, 2315.4674424882287, 2315.78000089992, 2329.743728189898, 2341.9297421077395, 2353.1646265575732, 2168.991418990177, 2525.5832787590025, 2541.4917016596755, 2564.7691707746394, 2567.6662033935654, 8770.824583508358, 8776.254018408443, 8791.428557143765, 8823.0, 8832.602532886036, 5355.143177091685, 5426.647267927572, 5431.266778984826, 5534.391216966131, 5559.193916882029, 3558.3417067842533, 3637.636236376368, 3651.5618125824803, 3680.834362453696, 3693.279810436966, 1023.923205759571, 1055.4406164732704, 1057.1595581512715, 1058.7194393485731, 1058.8570542976754, 9578.0, 11570.595029174023, 11818.231814932002, 11920.403979800974, 12101.939490302491, 4557.521460246693, 4913.164761990471, 4953.455119936804, 5048.949510504922, 5078.97460512695, 7608.619569021526, 9189.954050229706, 9772.827260728758, 10238.590456381662, 10369.9481502592, 5452.482014208644, 5486.670799752028, 5515.090010148361, 5518.972405137949, 5547.861303467364, 4373.059792144704, 4463.018136010072, 4560.8175672973375, 4785.186518291899, 4979.2033274676605, 3312.271300313927, 3491.720662347006, 3858.151206734514, 4052.9392059119136, 4075.042365044212, 1333.293354522105, 1360.3266383140408, 1364.5087768403366, 1369.801468642834, 1373.1898180073604, 1343.818584491081, 1373.7115205806692, 1377.8966577506726, 1386.5840247925582, 1387.5629176809273, 7965.0, 7990.04119505663, 8036.83926321482, 8069.959650201711, 8167.673293068329, 513.9948600514022, 532.8907573947331, 534.8769782949944, 540.6539814518711, 543.9456054394528, 6116.418940200763, 6180.381961803873, 6184.845378865564, 6240.375962403814, 6241.063840423973, 8526.445781024213, 10282.897171028344, 10540.9986051325, 10546.630867919586, 10686.893131068746, 10009.899901001043, 10511.0, 10529.789404211873, 10558.260921735558, 10561.735956601147, 7238.624661314333, 8200.015998080149, 8301.29438997692, 8304.418690691593, 8381.622826972678, 7977.960110199412, 7992.0, 8018.3585313173635, 8037.075736290401, 8082.555459449787, 9217.44695318283, 9256.53717314145, 9434.575444104894, 9465.621375145192, 9465.763355915882, 9601.663941762004, 9919.40483570988, 9959.701208963743, 9962.103410692782, 9991.750206244611, 6769.559978601375, 7244.710211591478, 7497.362724168507, 7531.8117047074265, 7639.159692433716, 8168.3465322772845, 8209.384296177692, 8257.504549727035, 8258.83482330338, 8259.256666900008, 7249.166345870292, 7339.376153027052, 7367.189609142883, 7495.437842161969, 7516.924830751623, 7270.454715896223, 7303.269673032654, 7323.194448610755, 7351.8162045949275, 7398.11222653285, 7543.3965282778345, 7596.126445458843, 7661.923380766344, 7728.536287822749, 7766.068071831416, 6821.147356580427, 6977.232504424408, 7046.330598593126, 7060.046893669494, 7062.823429414306, 7088.397486213729, 7103.041089453064, 7115.6086415247655, 7149.857002860018, 7163.06880105583], "unit": "score", "name": "mootools.html", "value": 4831.7244664175405}, {"lowerIsBetter": false, "replicates": [319.5621997862928, 336.77772670037774, 342.98456569454373, 345.08208166277706, 346.8525876502486, 5479.890402191959, 5548.167774833777, 6789.185297764269, 6844.726210951556, 6898.448124150069, 5557.833265002047, 6091.406070418452, 6092.0, 6347.857385670577, 6685.565438246511, 4398.538153493885, 4772.0, 4854.053459575384, 4978.775955082012, 4985.252212168168, 4967.205247160455, 4969.950300496985, 4976.62675299354, 4983.127952608297, 4988.351514303154, 4918.827841025565, 4927.236278376839, 4929.531694489017, 4933.728644924546, 4949.529794669501, 4054.7972601369815, 4194.958050419503, 4680.134175177603, 4971.751412429364, 4973.378327709036, 3389.3560223557447, 3550.928981420357, 3605.56733192016, 3828.2343531293855, 4317.956820431787, 6348.809660667062, 6630.9668451657435, 6650.2352229493745, 6668.466522678174, 6688.565243259172, 4817.831375901862, 5779.162021506858, 5791.247137872092, 5843.357230704619, 5850.824475265749, 5850.5612079094235, 7270.345668889825, 7274.745383911591, 7280.41756659466, 7282.96358518204, 3832.156925476391, 4631.675782695213, 4686.929696054562, 4688.320193571947, 4689.859304220879, 7619.885701714424, 7714.884276735854, 7719.729809456699, 7724.725420305643, 7736.110347310075, 4485.349624304457, 4517.932231016537, 4735.289706544046, 4760.119377915097, 4765.0946320199055, 4776.785044672929, 4813.109574728616, 4816.8795780105775, 4825.734584597881, 4845.563899249014, 5334.973325133349, 5504.2294078829, 5794.913076303858, 5794.956907756644, 5816.243888294579, 7327.2672732726305, 7330.157031941289, 7330.96334518324, 7348.338649521462, 7356.852862942711, 1420.4247279851677, 1608.228050535726, 1623.9756403653955, 1626.414490783317, 1636.7626694129285, 1033.4419413516766, 1069.3316677076828, 1072.340510585984, 1076.2251179150999, 1090.5038207615517, 6750.662466876636, 6825.419839313615, 6854.177498700188, 6858.0, 6894.586324820427, 7516.323530882247, 7534.246575342422, 7544.660490277951, 7564.562733080697, 7586.734464293723, 6562.80311590653, 6779.491538134561, 6905.274946130584, 6911.3779759821855, 6925.168979722465, 3437.8796742114405, 4010.2981978153707, 4041.9797901010306, 4046.393041043867, 4050.5746896576024, 7988.281054705104, 7999.0, 8012.0, 8031.156728543536, 8036.598170091589, 6311.990081586924, 7601.239876012354, 7866.842663146705, 7877.645505952246, 7901.446898717035, 8079.717209897625, 8085.312748416451, 8086.948696669396, 8101.6354264058255, 8102.473339232931, 7667.3099421052375, 7688.769336919901, 7691.88462173079, 7719.266669666373, 7728.0, 6131.478824299985, 7539.359154471931, 7558.281963213486, 7566.35685966677, 7570.545767253982, 7713.575753333621, 8047.195280471906, 8053.959730201546, 8119.79700507492, 8129.0, 4893.339399181065, 4935.629827763004, 4949.133901567139, 4949.901001980013, 4968.155413579772, 7448.776536703907, 7454.552726836408, 7456.739014134696, 7463.0, 7482.625868706652, 7276.927230727837, 7298.4891057625455, 7308.671109800178, 7311.41508679315, 7315.926840731525, 5979.372165922516, 7344.008558844487, 7351.632418378953, 7357.963210183915, 7393.963030184815, 7162.462815288978, 7162.498625096402, 7194.784156475314, 7199.640017998974, 7206.89189662166, 5899.970500147472, 7312.670929808065, 7333.963330183315, 7341.669624866787, 7374.0, 5501.367342755474, 7141.9642901785155, 7142.392896603847, 7176.246494118042, 7180.210176880434], "unit": "score", "name": "prototype.html", "value": 5232.114851576872}, {"lowerIsBetter": false, "replicates": [746.5781833264209, 754.3286475037214, 761.4137114421895, 782.9686812527499, 783.2480818414322, 14711.558653240407, 14943.701125977474, 14995.775063374058, 15051.548453546397, 15106.471273505429, 13906.374213160407, 13907.930460347709, 13992.79010814836, 14214.289285535733, 14219.289035548207, 773.4083426178978, 945.1493655709847, 949.9952500237524, 958.8897276813186, 968.099667309402, 958.520739630185, 962.8651988721584, 963.4123184857232, 964.2093483343662, 965.242284806427, 955.1976339874504, 959.4579062829514, 960.9663661771839, 1008.0473952115254, 1012.7113772574818, 955.5795450002047, 1001.7295330260825, 1002.5989604158322, 1005.7234260578326, 1006.1648831469862, 619.3342157181004, 712.4763298975249, 732.1945859554447, 752.3529764402609, 753.0737193252276, 14890.181040042793, 14924.62688432787, 14963.850361496354, 15021.924890375587, 15055.623609409742, 12154.270743755404, 12565.434555445026, 12576.182548134342, 12605.873941260654, 12772.872271277261, 9807.215422766161, 9971.202303815677, 10002.0, 10042.69871903844, 10327.79344413115, 3323.4516304809677, 3500.3524347995703, 3532.2405682778067, 3582.5676892388774, 3627.5102861113673, 73308.90036649455, 73411.89882151772, 73569.63215183944, 73647.26352736457, 75963.86054209137, 9375.573511103192, 9381.29640276982, 9421.152096311227, 9552.092551207763, 9617.374870633386, 21049.473763156042, 21503.569928601653, 21636.0, 21649.35051948444, 21681.34955951324, 7242.601656908921, 7302.780916572511, 7393.926060739432, 7547.433942454228, 7555.433342499335, 4067.491563554556, 4119.814608342572, 4122.876313710533, 4130.834766609302, 4139.875803725893, 3293.1108600677685, 3449.9995001449297, 3480.164760457472, 3492.1793378556017, 3499.825008749552, 603.3272900715758, 635.3773302163905, 642.3351830855042, 648.3386945315846, 653.1378580273993, 484.2373759515367, 547.5975158258756, 572.7365411910484, 603.9129566779867, 613.8066509049635, 7617.6572054257695, 7897.842043159219, 8018.158093400109, 8045.798855028554, 8226.0, 541.748087139482, 575.2234483447396, 610.8198081565948, 616.1035693066577, 622.3247776162824, 3616.8553257869917, 3790.905227369338, 3805.0, 3836.55879573847, 3842.8462861485227, 76662.61668691621, 78448.0, 78508.0, 78842.0, 78983.21016789759, 66720.6663966677, 67450.98823517651, 70853.0, 71658.64170679114, 73010.63494682492, 52445.951080978164, 62889.68555157195, 63333.0, 63587.36412635907, 65433.67283163554, 8332.625031873702, 8352.0, 8439.620217090123, 8495.617697203517, 8559.57202139903, 43820.3141319594, 46060.0, 46119.538804612865, 46318.76840615775, 47066.823329417035, 53948.0, 57349.0, 59244.33400497074, 60049.0, 62231.0, 9138.588763505526, 9706.611735530782, 10092.444915529422, 10695.518701658288, 11013.218050573818, 11689.298642081503, 11708.414579271173, 11721.179517433698, 11722.765544688888, 11759.235649682743, 10864.565417383215, 10868.782624347627, 10905.291156074829, 10995.505202266077, 11727.237729547553, 10982.0, 11126.109911206922, 11441.027512661183, 11656.708582285512, 12039.518419263131, 10901.182411319025, 10934.835977460503, 11009.834852477059, 11286.266392684449, 11367.616779539148, 8552.957235213784, 9413.199878010446, 9513.0, 9531.284368813403, 9566.091221333962, 8705.390622656354, 9186.632534698538, 9271.76820579491, 9292.442453452815, 9294.674686386215], "unit": "score", "name": "yui.html", "value": 6753.297109220242}], "name": "dromaeo_css", "value": 7547.172456049392}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 115.0, 115.0, 115.0, 130.0, 114.0, 115.0, 118.0, 116.0], "unit": "score", "name": "ai-astar", "value": 116.3}, {"lowerIsBetter": true, "replicates": [156.0, 117.0, 145.0, 156.0, 121.0, 144.0, 145.0, 124.0, 158.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 138.9}, {"lowerIsBetter": true, "replicates": [193.0, 197.0, 198.0, 202.0, 221.0, 215.0, 268.0, 280.0, 199.0, 205.0], "unit": "score", "name": "audio-dft", "value": 217.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 75.0, 149.0, 57.0, 57.0, 57.0, 62.0, 96.0, 57.0], "unit": "score", "name": "audio-fft", "value": 75.4}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 123.0, 77.0, 83.0, 80.0, 120.0, 80.0, 79.0, 123.0], "unit": "score", "name": "audio-oscillator", "value": 92.9}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 88.0, 86.0, 82.0, 124.0, 89.0, 86.0, 89.0, 97.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.6}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 95.0, 94.0, 95.0, 94.0, 93.0, 108.0, 120.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 98.1}, {"lowerIsBetter": true, "replicates": [121.0, 149.0, 116.0, 92.0, 92.0, 90.0, 93.0, 92.0, 94.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 103.3}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 55.0, 57.0, 55.0, 59.0, 55.0, 61.0, 62.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 72.0, 76.0, 67.0, 67.0, 68.0, 68.0, 71.0, 73.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 87.0, 85.0, 86.0, 84.0, 87.0, 87.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [130.0, 125.0, 142.0, 135.0, 121.0, 123.0, 132.0, 136.0, 122.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.3}, {"lowerIsBetter": true, "replicates": [160.0, 178.0, 180.0, 141.0, 137.0, 130.0, 141.0, 140.0, 140.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.8}, {"lowerIsBetter": true, "replicates": [71.0, 76.0, 101.0, 95.0, 100.0, 95.0, 97.0, 80.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 85.2}], "name": "kraken", "value": 1510.1}]} 17:29:51 INFO - Return code: 0 17:29:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:29:51 ERROR - # TBPL SUCCESS # 17:29:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:29:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:29:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:29:51 INFO - 2016-03-10 17:29:51.456 screenresolution[2029:13537] starting screenresolution argv=screenresolution get 17:29:51 INFO - 2016-03-10 17:29:51.458 screenresolution[2029:13537] Display 0: 1600x1200x32@60 17:29:51 INFO - 2016-03-10 17:29:51.464 screenresolution[2030:13540] starting screenresolution argv=screenresolution list 17:29:51 INFO - Available Modes on Display 0 17:29:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:29:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:29:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:29:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:29:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:29:51 INFO - Intel Iris: 17:29:51 INFO - Chipset Model: Intel Iris 17:29:51 INFO - Type: GPU 17:29:51 INFO - Bus: Built-In 17:29:51 INFO - VRAM (Dynamic, Max): 1536 MB 17:29:51 INFO - Vendor: Intel (0x8086) 17:29:51 INFO - Device ID: 0x0a2e 17:29:51 INFO - Revision ID: 0x0009 17:29:51 INFO - Displays: 17:29:51 INFO - Display: 17:29:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:29:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:29:51 INFO - Display Serial Number: 1600x1200 60 17:29:51 INFO - Main Display: Yes 17:29:51 INFO - Mirror: Off 17:29:51 INFO - Online: Yes 17:29:51 INFO - Rotation: Supported 17:29:51 INFO - Return code: 0 17:29:51 INFO - Running post-action listener: _resource_record_post_action 17:29:51 INFO - Running post-run listener: _resource_record_post_run 17:29:52 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 380928; Write bytes: 706878464; Read time: 8; Write time: 2515 17:29:52 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 386730496; Write bytes: 381224448; Read time: 28817; Write time: 712 17:29:52 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 380928; Write bytes: 302925312; Read time: 8; Write time: 1753 17:29:52 INFO - Running post-run listener: _upload_blobber_files 17:29:52 INFO - Blob upload gear active. 17:29:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:29:52 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 17:29:52 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'] 17:29:52 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 17:29:53 INFO - (blobuploader) - INFO - Open directory for files ... 17:29:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:29:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:29:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:54 INFO - (blobuploader) - INFO - Done attempting. 17:29:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:29:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:29:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:55 INFO - (blobuploader) - INFO - Done attempting. 17:29:55 INFO - (blobuploader) - INFO - Iteration through files over. 17:29:55 INFO - Return code: 0 17:29:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:29:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:29:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5f3007a05f4d8c6e9c16fed906d871bce7cca303bdca5ce8173623fde764bc9142e8013b9029f97337727a94ccef4e098de9d5f430173fe09dd5a48373462c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b41b8b83543a43910d7cd2bfd4404baa8104d2e0578fd510cbd0fa5fce35eb439b13a285bbb2b7c0c4c832b9123e80f2b318dbc9de1956d18eb274ef137d9a6"} 17:29:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:29:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:29:55 INFO - Contents: 17:29:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5f3007a05f4d8c6e9c16fed906d871bce7cca303bdca5ce8173623fde764bc9142e8013b9029f97337727a94ccef4e098de9d5f430173fe09dd5a48373462c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b41b8b83543a43910d7cd2bfd4404baa8104d2e0578fd510cbd0fa5fce35eb439b13a285bbb2b7c0c4c832b9123e80f2b318dbc9de1956d18eb274ef137d9a6"} 17:29:55 INFO - Running post-run listener: copy_logs_to_upload_dir 17:29:55 INFO - Copying logs to upload dir... 17:29:55 INFO - mkdir: /builds/slave/test/build/upload/logs 17:29:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.421952 ========= master_lag: 5.81 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-10 17:30:00.714779) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 17:30:00.718995) ========= 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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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/d5f3007a05f4d8c6e9c16fed906d871bce7cca303bdca5ce8173623fde764bc9142e8013b9029f97337727a94ccef4e098de9d5f430173fe09dd5a48373462c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b41b8b83543a43910d7cd2bfd4404baa8104d2e0578fd510cbd0fa5fce35eb439b13a285bbb2b7c0c4c832b9123e80f2b318dbc9de1956d18eb274ef137d9a6"} build_url:https://queue.taskcluster.net/v1/task/NCW95t1IS0257dABuoFLig/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/NCW95t1IS0257dABuoFLig/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/d5f3007a05f4d8c6e9c16fed906d871bce7cca303bdca5ce8173623fde764bc9142e8013b9029f97337727a94ccef4e098de9d5f430173fe09dd5a48373462c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b41b8b83543a43910d7cd2bfd4404baa8104d2e0578fd510cbd0fa5fce35eb439b13a285bbb2b7c0c4c832b9123e80f2b318dbc9de1956d18eb274ef137d9a6"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 17:30:00.830660) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 17:30:00.830958) ========= 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.3qtCyQPUH4/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.DR3GctQ2eC/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005323 ========= master_lag: 1.52 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 17:30:02.359386) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 17:30:02.363686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 17:30:02.364191) ========= ========= Total master_lag: 62.70 =========