builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0048 starttime: 1457760108.94 results: success (0) buildid: 20160311181831 builduid: 82a4817758a143ecbfac91458456a276 revision: 612013e2676d371df229abdd4819abe896cc310e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:48.938585) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:48.938965) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:48.939252) ========= 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.4mwFOAlehC/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.JTx797G1cV/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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.005766 basedir: '/builds/slave/test' ========= master_lag: 0.35 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:49.298741) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-03-11 21:21:49.299055) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-03-11 21:21:50.377941) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:50.378198) ========= 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.4mwFOAlehC/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.JTx797G1cV/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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.006060 ========= master_lag: 0.41 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:50.792933) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:50.793207) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:50.793542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:50.793824) ========= 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.4mwFOAlehC/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.JTx797G1cV/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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-11 21:21:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 44.2M=0s 2016-03-11 21:21:51 (44.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.424735 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:51.450869) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:51.451148) ========= 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.4mwFOAlehC/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.JTx797G1cV/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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.025551 ========= master_lag: 0.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:51.668043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 21:21:51.668355) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 612013e2676d371df229abdd4819abe896cc310e --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 612013e2676d371df229abdd4819abe896cc310e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4mwFOAlehC/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.JTx797G1cV/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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-11 21:21:51,808 truncating revision to first 12 chars 2016-03-11 21:21:51,808 Setting DEBUG logging. 2016-03-11 21:21:51,808 attempt 1/10 2016-03-11 21:21:51,808 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/612013e2676d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 21:21:52,515 unpacking tar archive at: fx-team-612013e2676d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.951508 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 21:21:52.790812) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:52.791108) ========= echo 612013e2676d371df229abdd4819abe896cc310e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'612013e2676d371df229abdd4819abe896cc310e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4mwFOAlehC/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.JTx797G1cV/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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 612013e2676d371df229abdd4819abe896cc310e program finished with exit code 0 elapsedTime=0.005875 script_repo_revision: '612013e2676d371df229abdd4819abe896cc310e' ========= master_lag: 0.10 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:52.893517) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:52.893814) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 21:21:53.252927) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-03-11 21:21:53.253209) ========= /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.4mwFOAlehC/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.JTx797G1cV/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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 21:21:53 INFO - MultiFileLogger online at 20160311 21:21:53 in /builds/slave/test 21:21:53 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 21:21:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:21:53 INFO - {'append_to_log': False, 21:21:53 INFO - 'base_work_dir': '/builds/slave/test', 21:21:53 INFO - 'blob_upload_branch': 'Fx-Team', 21:21:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:21:53 INFO - 'branch': 'Fx-Team', 21:21:53 INFO - 'buildbot_json_path': 'buildprops.json', 21:21:53 INFO - 'config_files': ('talos/mac_config.py',), 21:21:53 INFO - 'default_actions': ('clobber', 21:21:53 INFO - 'read-buildbot-config', 21:21:53 INFO - 'download-and-extract', 21:21:53 INFO - 'populate-webroot', 21:21:53 INFO - 'create-virtualenv', 21:21:53 INFO - 'install', 21:21:53 INFO - 'run-tests'), 21:21:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:21:53 INFO - 'download_minidump_stackwalk': True, 21:21:53 INFO - 'download_symbols': 'ondemand', 21:21:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:21:53 INFO - 'tooltool.py': '/tools/tooltool.py', 21:21:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:21:53 INFO - '/tools/misc-python/virtualenv.py')}, 21:21:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:21:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:21:53 INFO - 'installer_path': 'installer.exe', 21:21:53 INFO - 'log_level': 'info', 21:21:53 INFO - 'log_name': 'talos', 21:21:53 INFO - 'log_to_console': True, 21:21:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:21:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:21:53 INFO - 'opt_config_files': (), 21:21:53 INFO - 'pip_index': False, 21:21:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:21:53 INFO - 'cmd': ('bash', 21:21:53 INFO - '-c', 21:21:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:21:53 INFO - 'enabled': True, 21:21:53 INFO - 'halt_on_failure': False, 21:21:53 INFO - 'name': 'check_screen_resolution'},), 21:21:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:21:53 INFO - 'cmd': ('bash', 21:21:53 INFO - '-c', 21:21:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:21:53 INFO - 'enabled': True, 21:21:53 INFO - 'halt_on_failure': False, 21:21:53 INFO - 'name': 'check_screen_resolution'},), 21:21:53 INFO - 'run_cmd_checks_enabled': True, 21:21:53 INFO - 'sps_profile': False, 21:21:53 INFO - 'sps_profile_interval': 0, 21:21:53 INFO - 'suite': 'dromaeojs-e10s', 21:21:53 INFO - 'system_bits': '32', 21:21:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:21:53 INFO - 'title': 't-yosemite-r7-0048', 21:21:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:21:53 INFO - 'use_talos_json': True, 21:21:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:21:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:21:53 INFO - 'work_dir': 'build'} 21:21:53 INFO - ##### 21:21:53 INFO - ##### Running clobber step. 21:21:53 INFO - ##### 21:21:53 INFO - Running pre-action listener: _resource_record_pre_action 21:21:53 INFO - Running main action method: clobber 21:21:53 INFO - rmtree: /builds/slave/test/build 21:21:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:21:55 INFO - Running post-action listener: _resource_record_post_action 21:21:55 INFO - ##### 21:21:55 INFO - ##### Running read-buildbot-config step. 21:21:55 INFO - ##### 21:21:55 INFO - Running pre-action listener: _resource_record_pre_action 21:21:55 INFO - Running main action method: read_buildbot_config 21:21:55 INFO - Using buildbot properties: 21:21:55 INFO - { 21:21:55 INFO - "project": "", 21:21:55 INFO - "product": "firefox", 21:21:55 INFO - "script_repo_revision": "production", 21:21:55 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 21:21:55 INFO - "repository": "", 21:21:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 21:21:55 INFO - "buildid": "20160311181831", 21:21:55 INFO - "pgo_build": "False", 21:21:55 INFO - "basedir": "/builds/slave/test", 21:21:55 INFO - "buildnumber": 618, 21:21:55 INFO - "slavename": "t-yosemite-r7-0048", 21:21:55 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 21:21:55 INFO - "platform": "yosemite_r7", 21:21:55 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 21:21:55 INFO - "branch": "fx-team", 21:21:55 INFO - "repo_path": "integration/fx-team", 21:21:55 INFO - "revision": "612013e2676d371df229abdd4819abe896cc310e", 21:21:55 INFO - "stage_platform": "macosx64", 21:21:55 INFO - "builduid": "82a4817758a143ecbfac91458456a276", 21:21:55 INFO - "slavebuilddir": "test" 21:21:55 INFO - } 21:21:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 21:21:55 INFO - Running post-action listener: _resource_record_post_action 21:21:55 INFO - ##### 21:21:55 INFO - ##### Running download-and-extract step. 21:21:55 INFO - ##### 21:21:55 INFO - Running pre-action listener: _resource_record_pre_action 21:21:55 INFO - Running main action method: download_and_extract 21:21:55 INFO - mkdir: /builds/slave/test/build/tests 21:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:21:55 INFO - https://queue.taskcluster.net/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 21:21:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 21:21:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 21:21:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/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 21:21:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/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 21:22:12 INFO - Downloaded 1199 bytes. 21:22:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 21:22:12 INFO - Using the following test package requirements: 21:22:12 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 21:22:12 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:22:12 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 21:22:12 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:22:12 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 21:22:12 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:22:12 INFO - u'jsshell-mac.zip'], 21:22:12 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:22:12 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 21:22:12 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 21:22:12 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:22:12 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 21:22:12 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:22:12 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 21:22:12 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:22:12 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 21:22:12 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:22:12 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 21:22:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:22:12 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')]} 21:22:12 INFO - https://queue.taskcluster.net/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:22:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:22:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:22:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/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 21:22:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/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 21:22:14 INFO - Downloaded 17865217 bytes. 21:22:14 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'] 21:22:14 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 21:22:17 INFO - Return code: 0 21:22:17 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 21:22:17 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')]} 21:22:17 INFO - https://queue.taskcluster.net/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:22:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:22:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:22:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/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 21:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/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 21:22:30 INFO - Downloaded 17865217 bytes. 21:22:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:22:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:22:34 INFO - Return code: 0 21:22:34 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')]} 21:22:34 INFO - https://queue.taskcluster.net/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:22:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:22:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:22:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/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 21:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/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 21:22:35 INFO - Downloaded 10845263 bytes. 21:22:35 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'] 21:22:35 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 21:22:35 INFO - Return code: 0 21:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:22:35 INFO - https://queue.taskcluster.net/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:22:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:22:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:22:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 21:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrSqm126T_mCHxQfVT6riQ/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 21:22:39 INFO - Downloaded 110999677 bytes. 21:22:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:22:39 INFO - mkdir: /builds/slave/test/properties 21:22:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:22:39 INFO - Writing to file /builds/slave/test/properties/build_url 21:22:39 INFO - Contents: 21:22:39 INFO - build_url:https://queue.taskcluster.net/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:22:40 INFO - Running post-action listener: _resource_record_post_action 21:22:40 INFO - Running post-action listener: set_extra_try_arguments 21:22:40 INFO - ##### 21:22:40 INFO - ##### Running populate-webroot step. 21:22:40 INFO - ##### 21:22:40 INFO - Running pre-action listener: _resource_record_pre_action 21:22:40 INFO - Running main action method: populate_webroot 21:22:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:22:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:22:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:22:40 INFO - '--tppagecycles', 21:22:40 INFO - '7'], 21:22:40 INFO - 'tests': ['tsvgm']}}, 21:22:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:22:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:22:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:22:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:22:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:22:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:22:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:22:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:40 INFO - 'talos_options': ['--e10s'], 21:22:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:22:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:40 INFO - 'tests': ['damp', 'tps']}, 21:22:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:40 INFO - 'talos_options': ['--e10s'], 21:22:40 INFO - 'tests': ['damp', 'tps']}, 21:22:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:22:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:22:40 INFO - 'other': {'tests': ['a11yr', 21:22:40 INFO - 'ts_paint', 21:22:40 INFO - 'tpaint', 21:22:40 INFO - 'sessionrestore', 21:22:40 INFO - 'sessionrestore_no_auto_restore', 21:22:40 INFO - 'tabpaint']}, 21:22:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:22:40 INFO - 'tests': ['a11yr', 21:22:40 INFO - 'ts_paint', 21:22:40 INFO - 'tpaint', 21:22:40 INFO - 'sessionrestore', 21:22:40 INFO - 'sessionrestore_no_auto_restore', 21:22:40 INFO - 'tabpaint']}, 21:22:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:22:40 INFO - 'tests': ['a11yr', 21:22:40 INFO - 'ts_paint', 21:22:40 INFO - 'tpaint', 21:22:40 INFO - 'sessionrestore', 21:22:40 INFO - 'sessionrestore_no_auto_restore', 21:22:40 INFO - 'tabpaint']}, 21:22:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:22:40 INFO - 'tests': ['a11yr', 21:22:40 INFO - 'ts_paint', 21:22:40 INFO - 'tpaint', 21:22:40 INFO - 'sessionrestore', 21:22:40 INFO - 'sessionrestore_no_auto_restore', 21:22:40 INFO - 'tabpaint']}, 21:22:40 INFO - 'other_l64': {'tests': ['a11yr', 21:22:40 INFO - 'ts_paint', 21:22:40 INFO - 'tpaint', 21:22:40 INFO - 'sessionrestore', 21:22:40 INFO - 'sessionrestore_no_auto_restore', 21:22:40 INFO - 'tabpaint']}, 21:22:40 INFO - 'other_nol64': {'tests': ['a11yr', 21:22:40 INFO - 'ts_paint', 21:22:40 INFO - 'tpaint', 21:22:40 INFO - 'sessionrestore', 21:22:40 INFO - 'sessionrestore_no_auto_restore', 21:22:40 INFO - 'tabpaint']}, 21:22:40 INFO - 'svgr': {'tests': ['tsvgx', 21:22:40 INFO - 'tsvgr_opacity', 21:22:40 INFO - 'tart', 21:22:40 INFO - 'tscrollx', 21:22:40 INFO - 'cart']}, 21:22:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:22:40 INFO - 'tests': ['tsvgx', 21:22:40 INFO - 'tsvgr_opacity', 21:22:40 INFO - 'tart', 21:22:40 INFO - 'tscrollx', 21:22:40 INFO - 'cart']}, 21:22:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:40 INFO - 'tests': ['tp5o']}, 21:22:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:40 INFO - 'talos_options': ['--e10s'], 21:22:40 INFO - 'tests': ['tp5o']}, 21:22:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:40 INFO - 'talos_options': ['--xperf_path', 21:22:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:22:40 INFO - 'tests': ['tp5n']}, 21:22:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:40 INFO - 'talos_options': ['--e10s', 21:22:40 INFO - '--xperf_path', 21:22:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:22:40 INFO - 'tests': ['tp5n']}}, 21:22:40 INFO - 'talos.zip': {'path': '', 21:22:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:22:40 INFO - Running post-action listener: _resource_record_post_action 21:22:40 INFO - ##### 21:22:40 INFO - ##### Running create-virtualenv step. 21:22:40 INFO - ##### 21:22:40 INFO - Running pre-action listener: _resource_record_pre_action 21:22:40 INFO - Running main action method: create_virtualenv 21:22:40 INFO - Creating virtualenv /builds/slave/test/build/venv 21:22:40 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 21:22:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:22:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:22:40 INFO - Using real prefix '/tools/python27' 21:22:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:22:41 INFO - Installing distribute.............................................................................................................................................................................................done. 21:22:44 INFO - Installing pip.................done. 21:22:44 INFO - Return code: 0 21:22:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:22:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10984ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae3d5e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096f0d30>, '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 0x109514db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096e7b20>, '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.4mwFOAlehC/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.JTx797G1cV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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 21:22:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:22:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:22:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4mwFOAlehC/Render', 21:22:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:44 INFO - 'HOME': '/Users/cltbld', 21:22:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:44 INFO - 'LOGNAME': 'cltbld', 21:22:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:44 INFO - 'MOZ_NO_REMOTE': '1', 21:22:44 INFO - 'NO_EM_RESTART': '1', 21:22:44 INFO - 'PAGER': '/bin/cat', 21:22:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:44 INFO - 'PWD': '/builds/slave/test', 21:22:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:44 INFO - 'SHELL': '/bin/bash', 21:22:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTx797G1cV/Listeners', 21:22:44 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 21:22:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:44 INFO - 'USER': 'cltbld', 21:22:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:44 INFO - 'XPC_FLAGS': '0x0', 21:22:44 INFO - 'XPC_SERVICE_NAME': '0', 21:22:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:44 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 21:22:44 INFO - Cleaning up... 21:22:44 INFO - Return code: 0 21:22:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:22:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10984ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae3d5e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096f0d30>, '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 0x109514db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096e7b20>, '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.4mwFOAlehC/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.JTx797G1cV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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 21:22:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:22:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:22:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4mwFOAlehC/Render', 21:22:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:44 INFO - 'HOME': '/Users/cltbld', 21:22:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:44 INFO - 'LOGNAME': 'cltbld', 21:22:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:44 INFO - 'MOZ_NO_REMOTE': '1', 21:22:44 INFO - 'NO_EM_RESTART': '1', 21:22:44 INFO - 'PAGER': '/bin/cat', 21:22:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:44 INFO - 'PWD': '/builds/slave/test', 21:22:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:44 INFO - 'SHELL': '/bin/bash', 21:22:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTx797G1cV/Listeners', 21:22:44 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 21:22:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:44 INFO - 'USER': 'cltbld', 21:22:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:44 INFO - 'XPC_FLAGS': '0x0', 21:22:44 INFO - 'XPC_SERVICE_NAME': '0', 21:22:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:45 INFO - Downloading/unpacking psutil>=0.7.1 21:22: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 21:22: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 21:22: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 21:22: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 21:22: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 21:22: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 21:22:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:22:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:22:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:22:47 INFO - Installing collected packages: psutil 21:22:47 INFO - Running setup.py install for psutil 21:22:47 INFO - building 'psutil._psutil_osx' extension 21:22:47 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 21:22:48 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 21:22:48 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 21:22:48 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 21:22:48 INFO - building 'psutil._psutil_posix' extension 21:22:48 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 21:22:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:22:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:22:48 INFO - ^ 21:22:48 INFO - 1 warning generated. 21:22:48 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 21:22:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:22:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:22:48 INFO - Successfully installed psutil 21:22:48 INFO - Cleaning up... 21:22:48 INFO - Return code: 0 21:22:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10984ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae3d5e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096f0d30>, '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 0x109514db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096e7b20>, '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.4mwFOAlehC/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.JTx797G1cV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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 21:22:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:22:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4mwFOAlehC/Render', 21:22:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:48 INFO - 'HOME': '/Users/cltbld', 21:22:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:48 INFO - 'LOGNAME': 'cltbld', 21:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:48 INFO - 'MOZ_NO_REMOTE': '1', 21:22:48 INFO - 'NO_EM_RESTART': '1', 21:22:48 INFO - 'PAGER': '/bin/cat', 21:22:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:48 INFO - 'PWD': '/builds/slave/test', 21:22:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:48 INFO - 'SHELL': '/bin/bash', 21:22:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTx797G1cV/Listeners', 21:22:48 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 21:22:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:48 INFO - 'USER': 'cltbld', 21:22:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:48 INFO - 'XPC_FLAGS': '0x0', 21:22:48 INFO - 'XPC_SERVICE_NAME': '0', 21:22:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:22:49 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 21:22:49 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 21:22:49 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 21:22:49 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 21:22:49 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 21:22:49 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 21:22:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:22:51 INFO - Installing collected packages: mozsystemmonitor 21:22:51 INFO - Running setup.py install for mozsystemmonitor 21:22:51 INFO - Successfully installed mozsystemmonitor 21:22:51 INFO - Cleaning up... 21:22:51 INFO - Return code: 0 21:22:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:22:51 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')]} 21:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:51 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')]} 21:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:51 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 0x10984ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae3d5e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096f0d30>, '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 0x109514db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096e7b20>, '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.4mwFOAlehC/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.JTx797G1cV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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 21:22:51 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 21:22:51 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 21:22:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4mwFOAlehC/Render', 21:22:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:51 INFO - 'HOME': '/Users/cltbld', 21:22:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:51 INFO - 'LOGNAME': 'cltbld', 21:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:51 INFO - 'MOZ_NO_REMOTE': '1', 21:22:51 INFO - 'NO_EM_RESTART': '1', 21:22:51 INFO - 'PAGER': '/bin/cat', 21:22:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:51 INFO - 'PWD': '/builds/slave/test', 21:22:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:51 INFO - 'SHELL': '/bin/bash', 21:22:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTx797G1cV/Listeners', 21:22:51 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 21:22:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:51 INFO - 'USER': 'cltbld', 21:22:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:51 INFO - 'XPC_FLAGS': '0x0', 21:22:51 INFO - 'XPC_SERVICE_NAME': '0', 21:22:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:51 INFO - Downloading/unpacking blobuploader==1.2.4 21:22:51 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 21:22:51 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 21:22:51 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 21:22:51 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 21:22:51 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 21:22:51 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 21:22:54 INFO - Downloading blobuploader-1.2.4.tar.gz 21:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:22:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:22:54 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 21:22:54 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 21:22:54 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 21:22:54 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 21:22:54 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 21:22:54 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 21:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:22:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:22:54 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 21:22:54 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 21:22:54 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 21:22:54 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 21:22:54 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 21:22:54 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 21:22:55 INFO - Downloading docopt-0.6.1.tar.gz 21:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:22:55 INFO - Installing collected packages: blobuploader, requests, docopt 21:22:55 INFO - Running setup.py install for blobuploader 21:22:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:22:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:22:55 INFO - Running setup.py install for requests 21:22:56 INFO - Running setup.py install for docopt 21:22:56 INFO - Successfully installed blobuploader requests docopt 21:22:56 INFO - Cleaning up... 21:22:56 INFO - Return code: 0 21:22:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:22: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')]} 21:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22: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')]} 21:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:56 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 0x10984ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae3d5e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096f0d30>, '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 0x109514db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096e7b20>, '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.4mwFOAlehC/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.JTx797G1cV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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 21:22:56 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 21:22:56 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 21:22:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4mwFOAlehC/Render', 21:22:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:56 INFO - 'HOME': '/Users/cltbld', 21:22:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:56 INFO - 'LOGNAME': 'cltbld', 21:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:56 INFO - 'MOZ_NO_REMOTE': '1', 21:22:56 INFO - 'NO_EM_RESTART': '1', 21:22:56 INFO - 'PAGER': '/bin/cat', 21:22:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:56 INFO - 'PWD': '/builds/slave/test', 21:22:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:56 INFO - 'SHELL': '/bin/bash', 21:22:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTx797G1cV/Listeners', 21:22:56 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 21:22:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:56 INFO - 'USER': 'cltbld', 21:22:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:56 INFO - 'XPC_FLAGS': '0x0', 21:22:56 INFO - 'XPC_SERVICE_NAME': '0', 21:22:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:22:56 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-CPnEwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:22:57 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-50Uvy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:22:57 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-pKaJch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:22:57 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-2NgeFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:22:57 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-4Ol95t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:22:57 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-B5nZ0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:22:57 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-r4oN5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:22:57 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-_FGkPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:22:57 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-CleXTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:22:57 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-1H17Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:22:57 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-Jgvk0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:22:58 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-vN8oPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:22:58 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-28Emdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:22:58 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-slFPVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:22:58 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-0IGngS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:22:58 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-aMKr9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:22:58 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-9ExOS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:22:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:22:58 INFO - Running setup.py install for manifestparser 21:22:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:22:58 INFO - Running setup.py install for mozcrash 21:22:59 INFO - Running setup.py install for mozdebug 21:22:59 INFO - Running setup.py install for mozdevice 21:22:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:22:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:22:59 INFO - Running setup.py install for mozfile 21:22:59 INFO - Running setup.py install for mozhttpd 21:22:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:22:59 INFO - Running setup.py install for mozinfo 21:22:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:22:59 INFO - Running setup.py install for mozInstall 21:22:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:22:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:22:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:22:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:22:59 INFO - Running setup.py install for mozleak 21:23:00 INFO - Running setup.py install for mozlog 21:23:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:23:00 INFO - Running setup.py install for moznetwork 21:23:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:23:00 INFO - Running setup.py install for mozprocess 21:23:00 INFO - Running setup.py install for mozprofile 21:23:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:23:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:23:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:23:00 INFO - Running setup.py install for mozrunner 21:23:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:23:00 INFO - Running setup.py install for mozscreenshot 21:23:01 INFO - Running setup.py install for moztest 21:23:01 INFO - Running setup.py install for mozversion 21:23:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:23:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:23:01 INFO - Cleaning up... 21:23:01 INFO - Return code: 0 21:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:01 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 0x10984ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae3d5e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096f0d30>, '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 0x109514db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096e7b20>, '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.4mwFOAlehC/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.JTx797G1cV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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 21:23:01 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 21:23:01 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 21:23:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4mwFOAlehC/Render', 21:23:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:01 INFO - 'HOME': '/Users/cltbld', 21:23:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:01 INFO - 'LOGNAME': 'cltbld', 21:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:01 INFO - 'MOZ_NO_REMOTE': '1', 21:23:01 INFO - 'NO_EM_RESTART': '1', 21:23:01 INFO - 'PAGER': '/bin/cat', 21:23:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:01 INFO - 'PWD': '/builds/slave/test', 21:23:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:01 INFO - 'SHELL': '/bin/bash', 21:23:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTx797G1cV/Listeners', 21:23:01 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 21:23:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:01 INFO - 'USER': 'cltbld', 21:23:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:01 INFO - 'XPC_FLAGS': '0x0', 21:23:01 INFO - 'XPC_SERVICE_NAME': '0', 21:23:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:01 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-mlyRbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:01 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)) 21:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:01 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-fgIQpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:01 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)) 21:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:01 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-YjpUpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:01 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)) 21:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:01 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-anbDip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:02 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)) 21:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:02 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-O1a_eE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:02 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)) 21:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:02 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-n9DWdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:02 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)) 21:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:02 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-eS_J5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:02 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)) 21:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:02 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-3qIWOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:02 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)) 21:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:02 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-H2K148-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:02 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)) 21:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:02 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-lZQ5xB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:02 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)) 21:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:02 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-STxheC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:02 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)) 21:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:02 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-YvwNOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:02 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)) 21:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:02 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-3xSaxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:03 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)) 21:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:03 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-uHhtJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:03 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)) 21:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:03 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-8FWqlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:03 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)) 21:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:03 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-bl3tJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:03 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)) 21:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:03 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-LuxdrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:03 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)) 21:23:03 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)) 21:23:03 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)) 21:23:03 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)) 21:23:03 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)) 21:23:03 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)) 21:23:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:05 INFO - Downloading blessings-1.6.tar.gz 21:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:23:05 INFO - Installing collected packages: blessings 21:23:05 INFO - Running setup.py install for blessings 21:23:06 INFO - Successfully installed blessings 21:23:06 INFO - Cleaning up... 21:23:06 INFO - Return code: 0 21:23:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:23:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:06 INFO - Reading from file tmpfile_stdout 21:23:06 INFO - Current package versions: 21:23:06 INFO - blessings == 1.6 21:23:06 INFO - blobuploader == 1.2.4 21:23:06 INFO - docopt == 0.6.1 21:23:06 INFO - manifestparser == 1.1 21:23:06 INFO - mozInstall == 1.12 21:23:06 INFO - mozcrash == 0.17 21:23:06 INFO - mozdebug == 0.1 21:23:06 INFO - mozdevice == 0.48 21:23:06 INFO - mozfile == 1.2 21:23:06 INFO - mozhttpd == 0.7 21:23:06 INFO - mozinfo == 0.9 21:23:06 INFO - mozleak == 0.1 21:23:06 INFO - mozlog == 3.1 21:23:06 INFO - moznetwork == 0.27 21:23:06 INFO - mozprocess == 0.22 21:23:06 INFO - mozprofile == 0.28 21:23:06 INFO - mozrunner == 6.11 21:23:06 INFO - mozscreenshot == 0.1 21:23:06 INFO - mozsystemmonitor == 0.0 21:23:06 INFO - moztest == 0.7 21:23:06 INFO - mozversion == 1.4 21:23:06 INFO - psutil == 3.1.1 21:23:06 INFO - requests == 1.2.3 21:23:06 INFO - wsgiref == 0.1.2 21:23:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:06 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 0x10984ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae3d5e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096f0d30>, '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 0x109514db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096e7b20>, '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.4mwFOAlehC/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.JTx797G1cV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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 21:23:06 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 21:23:06 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 21:23:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4mwFOAlehC/Render', 21:23:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:06 INFO - 'HOME': '/Users/cltbld', 21:23:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:06 INFO - 'LOGNAME': 'cltbld', 21:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:06 INFO - 'MOZ_NO_REMOTE': '1', 21:23:06 INFO - 'NO_EM_RESTART': '1', 21:23:06 INFO - 'PAGER': '/bin/cat', 21:23:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:06 INFO - 'PWD': '/builds/slave/test', 21:23:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:06 INFO - 'SHELL': '/bin/bash', 21:23:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTx797G1cV/Listeners', 21:23:06 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 21:23:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:06 INFO - 'USER': 'cltbld', 21:23:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:06 INFO - 'XPC_FLAGS': '0x0', 21:23:06 INFO - 'XPC_SERVICE_NAME': '0', 21:23:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:06 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)) 21:23:06 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)) 21:23:06 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)) 21:23:06 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)) 21:23:06 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)) 21:23:06 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)) 21:23:06 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)) 21:23:06 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)) 21:23:06 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)) 21:23:06 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)) 21:23:06 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)) 21:23:06 INFO - Cleaning up... 21:23:06 INFO - Return code: 0 21:23:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:06 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 0x10984ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae3d5e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096f0d30>, '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 0x109514db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096e7b20>, '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.4mwFOAlehC/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.JTx797G1cV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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 21:23:06 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 21:23:06 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 21:23:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4mwFOAlehC/Render', 21:23:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:06 INFO - 'HOME': '/Users/cltbld', 21:23:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:06 INFO - 'LOGNAME': 'cltbld', 21:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:06 INFO - 'MOZ_NO_REMOTE': '1', 21:23:06 INFO - 'NO_EM_RESTART': '1', 21:23:06 INFO - 'PAGER': '/bin/cat', 21:23:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:06 INFO - 'PWD': '/builds/slave/test', 21:23:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:06 INFO - 'SHELL': '/bin/bash', 21:23:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTx797G1cV/Listeners', 21:23:06 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 21:23:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:06 INFO - 'USER': 'cltbld', 21:23:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:06 INFO - 'XPC_FLAGS': '0x0', 21:23:06 INFO - 'XPC_SERVICE_NAME': '0', 21:23:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:06 INFO - Downloading/unpacking jsonschema 21:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:23:09 INFO - Downloading/unpacking functools32 (from jsonschema) 21:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:09 INFO - Downloading functools32-3.2.3-2.tar.gz 21:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:23:09 INFO - warning: no files found matching '*.txt' 21:23:09 INFO - no previously-included directories found matching 'build' 21:23:09 INFO - no previously-included directories found matching 'dist' 21:23:09 INFO - no previously-included directories found matching '.git*' 21:23:09 INFO - Installing collected packages: jsonschema, functools32 21:23:09 INFO - Running setup.py install for functools32 21:23:09 INFO - warning: no files found matching '*.txt' 21:23:09 INFO - no previously-included directories found matching 'build' 21:23:09 INFO - no previously-included directories found matching 'dist' 21:23:09 INFO - no previously-included directories found matching '.git*' 21:23:09 INFO - Successfully installed jsonschema functools32 21:23:09 INFO - Cleaning up... 21:23:10 INFO - Return code: 0 21:23:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10984ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae3d5e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096f0d30>, '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 0x109514db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096e7b20>, '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.4mwFOAlehC/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.JTx797G1cV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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 21:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 21:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:23:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4mwFOAlehC/Render', 21:23:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:10 INFO - 'HOME': '/Users/cltbld', 21:23:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:10 INFO - 'LOGNAME': 'cltbld', 21:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:10 INFO - 'MOZ_NO_REMOTE': '1', 21:23:10 INFO - 'NO_EM_RESTART': '1', 21:23:10 INFO - 'PAGER': '/bin/cat', 21:23:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:10 INFO - 'PWD': '/builds/slave/test', 21:23:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:10 INFO - 'SHELL': '/bin/bash', 21:23:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTx797G1cV/Listeners', 21:23:10 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 21:23:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:10 INFO - 'USER': 'cltbld', 21:23:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:10 INFO - 'XPC_FLAGS': '0x0', 21:23:10 INFO - 'XPC_SERVICE_NAME': '0', 21:23:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:10 INFO - Downloading/unpacking flake8 21:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:23:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:23:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:23:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:23:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:23:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:23:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:23:13 INFO - no previously-included directories found matching 'docs/_build' 21:23:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:23:14 INFO - Running setup.py install for pep8 21:23:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:23:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:23:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:23:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:23:14 INFO - no previously-included directories found matching 'docs/_build' 21:23:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:23:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:23:14 INFO - Cleaning up... 21:23:14 INFO - Return code: 0 21:23:14 INFO - Running post-action listener: _resource_record_post_action 21:23:14 INFO - Running post-action listener: _start_resource_monitoring 21:23:14 INFO - Starting resource monitoring. 21:23:14 INFO - ##### 21:23:14 INFO - ##### Running install step. 21:23:14 INFO - ##### 21:23:14 INFO - Running pre-action listener: _resource_record_pre_action 21:23:14 INFO - Running main action method: install 21:23:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:14 INFO - Reading from file tmpfile_stdout 21:23:14 INFO - Detecting whether we're running mozinstall >=1.0... 21:23:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:23:14 INFO - Reading from file tmpfile_stdout 21:23:14 INFO - Output received: 21:23:14 INFO - Usage: mozinstall [options] installer 21:23:14 INFO - Options: 21:23:14 INFO - -h, --help show this help message and exit 21:23:14 INFO - -d DEST, --destination=DEST 21:23:14 INFO - Directory to install application into. [default: 21:23:14 INFO - "/builds/slave/test"] 21:23:14 INFO - --app=APP Application being installed. [default: firefox] 21:23:14 INFO - mkdir: /builds/slave/test/build/application 21:23:14 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'] 21:23:14 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 21:23:48 INFO - Reading from file tmpfile_stdout 21:23:48 INFO - Output received: 21:23:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:23:48 INFO - Running post-action listener: _resource_record_post_action 21:23:48 INFO - ##### 21:23:48 INFO - ##### Running run-tests step. 21:23:48 INFO - ##### 21:23:48 INFO - Running pre-action listener: _resource_record_pre_action 21:23:48 INFO - Running main action method: run_tests 21:23:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:23:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:23:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:23:48 INFO - 2016-03-11 21:23:48.732 screenresolution[1651:9400] starting screenresolution argv=screenresolution get 21:23:48 INFO - 2016-03-11 21:23:48.735 screenresolution[1651:9400] Display 0: 1600x1200x32@60 21:23:48 INFO - 2016-03-11 21:23:48.741 screenresolution[1652:9402] starting screenresolution argv=screenresolution list 21:23:48 INFO - Available Modes on Display 0 21:23:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:23:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:23:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:23:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:23:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:23:48 INFO - Intel Iris: 21:23:48 INFO - Chipset Model: Intel Iris 21:23:48 INFO - Type: GPU 21:23:48 INFO - Bus: Built-In 21:23:48 INFO - VRAM (Dynamic, Max): 1536 MB 21:23:48 INFO - Vendor: Intel (0x8086) 21:23:48 INFO - Device ID: 0x0a2e 21:23:48 INFO - Revision ID: 0x0009 21:23:48 INFO - Displays: 21:23:48 INFO - Display: 21:23:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:23:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:23:48 INFO - Display Serial Number: 1600x1200 60 21:23:48 INFO - Main Display: Yes 21:23:48 INFO - Mirror: Off 21:23:48 INFO - Online: Yes 21:23:48 INFO - Rotation: Supported 21:23:48 INFO - Return code: 0 21:23:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:23:48 INFO - Python 2.7.3 21:23:48 INFO - Return code: 0 21:23:48 INFO - grabbing minidump binary from tooltool 21:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:23:48 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 0x1096f0d30>, '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 0x109514db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096e7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:23:48 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 21:23:48 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 21:23:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:23:49 INFO - Return code: 0 21:23:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:23:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:23:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:23:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:23:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:23:50 INFO - Return code: 0 21:23:50 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/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0048', '--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 21:23:50 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/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0048 --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 21:23:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4mwFOAlehC/Render', 21:23:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:50 INFO - 'HOME': '/Users/cltbld', 21:23:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:50 INFO - 'LOGNAME': 'cltbld', 21:23:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:23:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:50 INFO - 'MOZ_NO_REMOTE': '1', 21:23:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:23:50 INFO - 'NO_EM_RESTART': '1', 21:23:50 INFO - 'PAGER': '/bin/cat', 21:23:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:50 INFO - 'PWD': '/builds/slave/test', 21:23:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:23:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:50 INFO - 'SHELL': '/bin/bash', 21:23:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTx797G1cV/Listeners', 21:23:50 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 21:23:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:50 INFO - 'USER': 'cltbld', 21:23:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:50 INFO - 'XPC_FLAGS': '0x0', 21:23:50 INFO - 'XPC_SERVICE_NAME': '0', 21:23:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:50 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/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0048', '--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 21:23:50 INFO - mozversion application_buildid: 20160311181831 21:23:50 INFO - mozversion application_changeset: 612013e2676d371df229abdd4819abe896cc310e 21:23:50 INFO - mozversion application_display_name: Nightly 21:23:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:23:50 INFO - mozversion application_name: Firefox 21:23:50 INFO - mozversion application_remotingname: firefox 21:23:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:23:50 INFO - mozversion application_vendor: Mozilla 21:23:50 INFO - mozversion application_version: 48.0a1 21:23:50 INFO - mozversion platform_buildid: 20160311181831 21:23:50 INFO - mozversion platform_changeset: 612013e2676d371df229abdd4819abe896cc310e 21:23:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:23:50 INFO - mozversion platform_version: 48.0a1 21:23:50 INFO - using testdate: 1457760230 21:23:50 INFO - actual date: 1457760230 21:23:50 INFO - starting webserver on 'localhost:49270' 21:23:50 INFO - SUITE-START | Running 2 tests 21:23:50 INFO - TEST-START | dromaeo_css 21:23:50 INFO - operating with platform_type : mac_ 21:23:50 INFO - Initialising browser for dromaeo_css test... 21:23:50 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/tmpFWbCav/profile http://localhost:49270/getInfo.html) 21:23:53 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 21:23:53 INFO - PROCESS | 1670 | colorDepth:24 21:23:53 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 21:23:53 INFO - PROCESS | 1670 | __metrics 21:23:53 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 21:23:54 INFO - TEST-INFO | 1670: exit 0 21:23:54 INFO - Browser initialized. 21:23:54 INFO - Running cycle 1/1 for dromaeo_css test... 21:23:54 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/tmpFWbCav/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:24:06 INFO - PROCESS | 1675 | RSS: Main: 256151552 21:24:06 INFO - PROCESS | 1675 | 21:24:55 INFO - PROCESS | 1675 | 1457760295953 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] 21:27:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 21:27:08 INFO - PROCESS | 1675 | RSS: Main: 268640256 21:27:08 INFO - PROCESS | 1675 | 21:30:10 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 21:30:10 INFO - PROCESS | 1675 | RSS: Main: 280526848 21:30:10 INFO - PROCESS | 1675 | 21:33:12 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 21:33:13 INFO - PROCESS | 1675 | RSS: Main: 281952256 21:33:13 INFO - PROCESS | 1675 | 21:36:14 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 21:36:15 INFO - PROCESS | 1675 | RSS: Main: 284762112 21:36:15 INFO - PROCESS | 1675 | 21:39:17 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 21:39:18 INFO - PROCESS | 1675 | RSS: Main: 286441472 21:39:18 INFO - PROCESS | 1675 | 21:42:20 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 21:42:21 INFO - PROCESS | 1675 | RSS: Main: 288997376 21:42:21 INFO - PROCESS | 1675 | 21:42:21 INFO - PROCESS | 1675 | __start_tp_report 21:42:21 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 21:42:21 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 21:42:21 INFO - PROCESS | 1675 | |i|pagename|runs| 21:42:21 INFO - PROCESS | 1675 | |0;dojo.html;3261.842046073644;3469.6356882527334;3526.8765593204234;3529.8764543240977;3572.3748344039786;4736.526347365262;5045.318881950945;5713.5143512801405;5723.54211663067;5794.971025144879;5616;5748.482636562709;5749.511291540213;5757.165211044396;5908.40915908409;5059.721715305656;5099.7705103270255;5136.101182293102;5216.582673386139;5290.1800220965815;5217.191335343009;5245.239440281157;5260.684358938476;5278.102722537159;5291.259223708684;5102.132637451624;5106.055379754739;5189;5210.6613070150315;5223.477652234784;4395.63735242076;4958.231474121517;5218;5230.92153617696;5242.344706911636;5036.169032109698;5133.768980395891;5153;5177.663451875616;5179.7928082877015;5558.249636299129;5659.320881494205;5675.971620141873;5682.17608446777;5721;6151.138840562325;6173.567850250484;6225.657588832612;6226.377362263783;6246.906296405557;6097.252466530076;6193.668361302297;6219.2847822500535;6226.719797609118;6230.781922632731;5885.941140588625;5911.733971971272;5923.111533270044;5927.199828023205;5945.672987985659;5201.245819356248;6226.501879849601;6277.246730392382;6285.842853928689;6298.685065746694;6061.151348838646;6112.473085128069;6129.570930034944;6135.631862088199;6181.474574661114;6114.60152118864;6139.001538246403;6207.689615519206;6207.96896015517;6252.843678908063;6134.171886795226;6175.876482470326;6239.469645080219;6245.313015568284;6252.280987686474;6131.835460087213;6158.538109641795;6172.444479996821;6186.319504854462;6218.595791273643;4826.638002149853;4867.367242258484;4888.633352498577;4891.755412229374;4916.754162291871;4389.846355377546;4402.031553058322;4425.3140763181755;4435.423394958635;4462.866114016585;5726.3128424588485;5839;5854.326752423441;5857.179994800731;5944.494717949023;6212.689365531705;6230.875382492325;6249.812505624838;6250.124982502453;6253.343398943137;5655.293088363955;5776.133579962955;5933.406659334119;5935.792247271324;5943.286805583358;5329.413764485904;5338;5369.382521010056;5384.246205531229;5417.674939503642;6344.365563443711;6354.3963323484195;6354.90467642995;6358.904616430757;6377.23473183221;6163.9383606163365;6226.906596400967;6250.249970003629;6261.5616906816085;6271.184745983175;6153.046277826944;6223.844403889939;6281.057841323838;6349.936500635119;6362.363763623601;5582.827606202581;6182.6599537025895;6192.845178870564;6196.721147548461;6209.751609935552;5161.741912904415;5582.665040097607;6237.345078766845;6240.126382306572;6359.268684101387;6014.338422773404;6037.09443583466;6107.158472117419;6148.754049838135;6180.536459765445;6081;6104;6114.57197996136;6122.755089796358;6128.479079278133;5835.503982161564;5837.29952405714;5978.312494063239;6002.969985150046;6032.517398608188;5178.663386879841;6118.60229085108;6122.846928826815;6138.878900475427;6173.56785025044;6001.189839371804;6042.335343112166;6046;6064.181335519648;6082 21:42:21 INFO - PROCESS | 1675 | |1;ext.html;453.6801554903791;563.0962305499676;568.9474472226382;573.6414740787009;638.0907207229698;31657.208569785766;38596;38659.61340386595;38804.41793373102;39773.60226397735;42141;42456.57543424565;42921.14157716851;42978.57021429785;42985.925351866215;9578.760530986712;9716.854247186298;9819;9828.55771490281;9891.703248902508;9705.126538611523;9725.416475011487;9780.413175209475;9810.46042467664;9815.4601496918;9708.563114659823;9763.658271960483;9811.215102791759;9824.263180261472;9832.90167098327;9746.756331091745;9800.411975281435;9800.705978820612;9827.11555959967;9832.508374581243;9703.563339649732;9799.216062714966;9820;9839.212862971017;9850.408975461496;39671.20657586861;39816.60183398187;39952.20095598101;39973.60026399728;40278.59721402778;2637.5384307746067;2688.2876037849987;3151.7636177286795;3549.4143466328023;4023.5515214522748;27368.042118525755;27372.58941115885;27634.447311053867;27858.16425507238;28154;2698.608701738237;2728.945421091587;2753.1190019193864;2767.529519981608;2837.531807251801;407057.96471017454;548086;548756;553097;555251;70988.64505677439;71617.98674092763;72583.27416725871;72700.63649681823;72830;74002.51994960071;76064;76620;76707;77250.6137469309;17016;17260.827391726172;17283.308667653153;17416.912915435594;17420.39028634017;13124.884384827206;13134.146280491737;13197.406116724771;13210.669733256553;13222.471101156038;22143.667844982338;22288.77711222867;22464.887675561844;22541.88729056344;22551.887240563694;7590.8861367079535;8211.794705132419;9315.161635452841;9773.9022609773;9885.505724713736;760.8017372638117;813.6135335715488;1016.4561959351711;1053.5724093852873;1111.6665000499818;29755.85122074419;29898;30006.448806970344;30456.54315185274;31164.909228176904;1058.5183741397645;1074.7044562745307;1086.4947799273375;1140.669205930271;1190.9940450297693;13050.608481745563;15190;15237.6190595236;15445.768313475306;15535.45625903088;528999;530092;534028;537090;537519;60505.69747151236;60688.69655651694;60852;61337;61629.691851540454;1423.3239211374514;1432.2122832442324;1474.1965628732366;1477.8596033376812;1492.7910092587047;29234.56148157737;29659;29782.822165398058;29930.802767889913;30151;53610.73194634002;54076.729616351666;54077.64805879885;54124.646883826645;54274.45725542852;494320;495669;497480;498464;499093.504532475;32913.50629740508;33902.66097338995;34208.82895585506;34262.65737342694;34307.65692343045;36641.81679091587;45492.545074548834;45738;46207.84480388017;46538.30192547047;37296.81351593225;38312.42531361976;38380.42429363618;39121.41317880177;39290;36794.080147996516;37219.06952326214;37922;38206;38262.043448914;31279.84360078185;34185;36758.26483470369;37144;37216.883493494155;31298.374032519678;31349.733047253496;32300;32536.83731581327;32559.51160732638;24422.35975164713;24495.38761530976;24581.38546536351;24924.50150997006;25258.36854078663 21:42:21 INFO - PROCESS | 1675 | |2;jquery.html;356.1292639496431;364.4060181903497;369.12149085177276;371.5244487056569;372.5231703419624;16325.183740812956;16728.665426691474;16975.981441113527;20902.477438064056;20931.895340523315;16396.426125085625;19889;20051.1979520819;20446.18215271391;20586.42669666292;4869.951300487003;6046.1837651917085;6071.058985857199;6072.757089716406;6073.119397687333;4275.315949448089;5947.316058653245;6371.490280777527;6618.271990081087;6645.269020407752;6511.9348806512035;6586.308437614053;6587.242467116271;6588.472922166239;6608.9339106608795;6382.266039405481;6549.574277671936;6551.705173267214;6561.540692151551;6575.901361479581;5345.572354211654;5631.549476041907;5641.435856414326;5642.858928526779;5644.463775941279;13248.987702646637;13298.534551290755;13542.86457135426;13573.574774648718;13599.320033998261;2019.5657933544358;2065.917363305466;2074.097767471155;2109.177420805887;2196.560687862434;9957.5021248938;10002.649907253211;10046.598136074548;10074.395536267773;10149.238807089498;1733.0641453615033;1760.5070580237555;1767.1164417791103;1779.851995462932;1793.9910300448414;73412.63293683551;97713.51143244309;99135;99689;100746.49626751893;8663.740087797376;10658.200634952409;10845.83731244032;10889.83665245022;10899.29154604948;12747.808782868078;12757.42591583381;12759.42582583786;12760.170588911877;12808.551700690432;8288.917110828814;8422.578871056423;8490.660373585111;8558.95720521406;8564.443311184878;7381.386633354154;8774.517401542977;8830.602622881986;8865.113488651083;8874.423162494417;4177.248095342868;4193.979030104891;4217.261979153636;4224.324108142682;4257.425247591597;1800.324878170686;1853.4532312967706;1902.6289873474816;1910.2931915191468;1928.5660726336462;783.2167832167833;942.3827393057559;1013.9695809125591;1019.5106348952544;1025.7999690060367;19178.424647260603;20088;20322.390328290174;20450.488737781674;20568.382948511568;788.7949133225288;909.0093592082108;917.1516347378648;946.8106378724283;948.0708905272734;10591.682249532527;10942.945285273681;10960.890391096147;10969.229847646862;10975.945120274508;527490;616807.9159604174;633839;657796;676340;108036.45981770198;116299.41850290695;117039;118370;118683.81316186901;986.2898712926682;1016.5628779624684;1027.9383237005804;1029.9588016479406;1039.4335087377397;14972.47596334123;15450.5364839055;16638.3344666212;17445.30218791234;17893.552661183574;34551.30897381988;38801.61198388093;40682;52475.73762131165;55215.89568208533;48771.75614121907;58565.828683426946;65137;66231.67536649144;66518.3370415724;7535.660895259617;7700.730474433368;7806.297433231037;7881.881771773543;8081.595920204084;9009.459432434074;11766.176367654181;11780.76438471243;11847.289162650268;12489.31308778026;10970.835437468284;11125.499352528994;11139.443027848738;11192.776144477228;11316.830247546459;10737.46312684347;10890.401027943539;11059.834102488308;11081.944590276997;11213.831792523282;11239.719007024889;11250.324980501196;11278;11561.190716649753;11648.126390520576;7841.529508229524;7855.057393112635;8018.398620103399;8049.235322644339;8198.836023279382;9589.34804583068;11085.556577736801;11109.777804444027;11150.832737509107;11490.88509114898 21:42:21 INFO - PROCESS | 1675 | |3;mootools.html;1428.3929330034737;1594.6013496625847;1804.2332008896217;1876.4558278099353;2020.444377796105;8133.959330203355;8764.25503832175;8906.554672266393;9155.267578593714;9193.172614464705;8855.91144088559;8903.643854245822;8917.063708310632;8938.642454301837;8990.145936136056;2177.7060096886876;2333.603287441139;2337.4623836517612;2339.63735620979;2340.1224540797202;2455.4966231922504;2491.9003239870385;2514.5976643737004;2520.231329444519;2525.532776436356;2502;2504.8371855829405;2522.8738563071865;2525.267672375009;2549.9745002550017;2498.475320182764;2515.9119430819924;2516.7609077137645;2535.1380530619494;2544.860032698201;2103.6423807952683;2531.0255551612577;2536.2771610091036;2538.0609174605515;2546.0579585553464;9062.139096785795;9083.182513573744;9107.408018478844;9124.635014599407;9139.26885849137;5521.089020311644;5541.196526503675;5582.692951887685;5685.800996965087;5703.17303990919;3674.9448758268645;3736.8878933631763;3787.2993496203017;3818.16000479894;3829.655331020194;1049.375621505203;1068.1027936533349;1069.9625513107003;1080.9568766140633;1097.13874608432;12163.635090947286;12325.383730813424;12347.814782778265;12362.876371236352;12383.690407739788;4995.725235112103;5008.64939454242;5103.413107492612;5114.872128196825;5130.871728206825;10433.895661043443;10434.739131521621;10494.003069708366;10525.21060920434;10544.103751181083;5682.460166284196;5711.828645140652;5716.142578613241;5716.685582292931;5734.655920644775;4373.978130109329;4482.932756008662;4944.826931057396;5063.265826455144;5146.922796158061;4050.563690426754;4079.0618157823865;4112.115895082572;4121.4848143982;4126.690498212646;1341.5774031180342;1355.098859258582;1358.9864101359058;1362.5776009436909;1364.40648317982;1349.5990104935508;1369.7671395862728;1395.386030146732;1398.6433459467771;1411.7176564687104;7093.538919970186;7315.524490908074;8396.160383961676;8542;8563.443376180529;464.5401052957615;494.9109160351171;497.1647631978311;506.0562051773416;512.6642049457611;6279.591826531261;6315.242170939425;6327.778527751507;6348.777792777323;6368.554201205964;10898.400587967737;11198.384088875027;11263.211575189822;11264.493097810619;11355.716107097389;10704.30422022566;11091.5563377464;11105.777884442266;11155.665330040112;11161.497732602053;8542.786430339167;8542.957285213533;8608.268297194683;8666.826663466822;8673.522956237468;8203.71287004952;8222;8225.670973161006;8504.574771261288;8537.957310213409;9706.660266890625;9905.55425005862;9991.300608957303;10021.198304135798;10224.1820654346;10133.290669653054;10319.277650564389;10350.430726310125;10362.222833287382;10459.477026148814;7804.2976132146105;7804.609769511615;7851;7861.292483676497;7923.3661307096445;8480.703175388831;8590.441621294596;8592.226699596817;8620.827583448421;8621.482711037357;7501.099868015873;7693.115291741521;7741.458097933316;7778.299953004257;7840.7062834633925;7511.474196806171;7598.620068996639;7627.54234745917;7740.8451830964195;7751.496152750054;7935.880961785462;8011.719589814328;8060.274575288252;8119.675212991414;8128.878066828884;7003.7548685795755;7179.282071792779;7184.281571842774;7239.457040722073;7298.23368546295;7277.59973201479;7316.817079573053;7321.194668586345;7326.780196594111;7327 21:42:21 INFO - PROCESS | 1675 | |4;prototype.html;325.4759836662973;327.0499199824509;330.932158907424;334.56506541496066;334.9949750753738;6772.390484856362;6797.184337879449;6811.625360605165;6836.179658440988;6866.656667166647;6721.731130754776;6763.9661801691045;6774.322567743223;6787.2873348298335;6798.694058767355;4745.549172828576;4822.662413631029;4938.876528086791;4957.677750946177;4976.925346119802;3819.0261483321715;4367.672424568154;4939.283803848458;4946.812764936407;4990.351254336932;4263.594958478955;4819.2530157825595;4866.343043689109;4908.484609116027;4927;3793.412021136728;4298.527162012176;4616.7765542131365;4879.999600081993;4922.409310882681;4213.768242746648;4253.510846252659;4254.468191476066;4267.591694740728;4278.507971583276;4981.402231732179;5266.552343050807;6583;6584.835379115512;6592.86814263712;5811.796587119473;5837.445442682938;5858.619189752652;5875.735591898375;5903.586748927577;6060.969635161989;7184.568925864465;7225.747098851515;7295.124585049775;7307.3058059484265;3897.8635747748694;4287.48550173978;4447.533009034069;4657.534246575349;4676.275177347517;7621.809454763676;7627.199144089846;7643.235676432312;7678.425922685836;7691.461597688108;4521.507902392268;4710.24636058229;4727.7163370197895;4728.385309909759;4728.59806916416;4799.904061880137;4807.4471435784635;4849.903001940012;4859.34398856157;4862.732549709729;4916.680415772963;5705.229793977843;5812.070068788974;5818.4763371296785;5830.3586605473365;7308.707651693979;7313.817154571178;7314.6708398121145;7329.377002954702;7463.925360746432;1642.884998050125;1675.23776681612;1677.874159438047;1679.8908070975347;1684.7304431290934;1026.5431882812077;1060.5704689600725;1063.0379506546587;1067.0876400677464;1081.4376524207369;6719.42884854783;6725.327467253235;6804.863902721918;6820;6834.589924604539;7578.014858068526;7586.658600362997;7592.240775922474;7603.01160849086;7632.69469221225;6568.310327415648;6689.464842812563;6829.829254268584;6837.282085381063;6866.244713081557;3974.940375894364;4003.579624139482;4013.678905687538;4029.0531725044593;4052.918941621151;7908.8813667793875;7931.087924888597;7939;7949.165337639464;7965.362770978308;7511.098668159747;7853.136155022943;7866.528008319519;7867.095284042294;7878.172791856887;7893;7901.222224999329;7925.28672419485;7939.087004994384;7945.721899733598;6191.318954914866;7646.426518011061;7660.2722741339485;7661.272179142972;7666.923330766621;7471.17817040136;7475.439342049477;7479;7491.587962662106;7516.699332026877;7627.618619069135;7924.445288829726;7934.761957141295;7935.246151615587;7939.364850812037;3456.8617255309505;4722.669413141047;4783.497732738151;4791.425028996543;4801.927971080367;7608.695652174072;7630.2751238632245;7647.349975252166;7650.770476885702;7655.1962043986805;7369.705211791683;7372.373348265458;7378.667959941923;7380.741674041383;7439.702411903463;7119.715211391486;7339.926600733925;7371.520851144658;7404.370628496423;7405.96316515699;5885.823425297248;6948.478864085113;7197.172325182671;7204.0994875640545;7216.7834964951135;6392.776252831129;6990.021397004525;7355.338019578264;7361.779146625609;7378.040854688856;5713.653931201492;7148.785536433916;7155.928440715526;7159.355657990805;7196.568205907663 21:42:21 INFO - PROCESS | 1675 | |5;yui.html;678.362339400963;707.137292503146;737.7012310014446;761.3376362564567;781.2539025230905;14883.18142502162;15045.699086018272;15264.084154950711;15271.923640381796;15273.847261527395;14059.086159399658;14102.435902563911;14151;14158.858411415882;14185.645358866033;714.1822613107988;895.2793001633698;913.9177474027337;941.8493041113423;945.0785484152965;848.6944699908029;910.7632015675939;923.7413524213231;929.4748467116058;932.0912110692055;969.8448248280276;971.6016433262364;978.6379039755265;979.2802290316647;980.8675828763097;775.6658547298638;794.3486341200218;896.1531352871539;955.3121752338305;970.3741086998881;694.9061876646639;708.950373473857;717.4188906985358;719.2879049740772;729.8394353242278;14672.119672819665;14930.1041937483;14977.475788347356;15019.924900375538;15078.623034424118;12964.870351296555;13212.933935330359;13248.337583120901;13291.268980206085;13322.134061285986;8396.580170991427;9691.224702023821;9943.701688949342;10096.495175241282;10144.594216231342;3444.156181735491;3488.5464889564446;3488.8604455821737;3512.438009918401;3519.3137338218803;80499.99999999942;80523.59738201271;80812.19187808105;81033;81039;9376.249900007982;9717.757056073655;9760.365576237522;9845.163161131384;10017.599296028224;22547.774522254567;22958;22983.195588154667;23041;23042.884785575963;7519.661615227328;7564.735234266885;7587.279208475186;7727.65225564851;8029.996250468691;3840.0975770693863;3844.115853353688;3855.479510266134;3873.2640798248244;3992;3623.927521449556;3636.8181590920876;3656.3784156693428;3678.7240956927803;3692.778433294011;642.6497558830449;656.8620589676221;662.4965026579738;668.7859884836805;673.8416472129046;520.591335801394;555.7165845418865;577.3533642320627;579.2730123694736;608.0787606775739;7755.883661745078;8049.758507244792;8076.990376202974;8083.878741818878;8147.75556733299;497.9816275716097;568.6218664588085;575.23493753308;602.4246844263718;629.2826178156905;3725.9441108382853;3795.582485926546;3848.9807550962064;3856.9807150964066;3861.995881070942;71042;73536.63231683808;90689.54655226813;90690;90985.54507227421;74994;76644.0181388208;77164.84252736214;77684;77835.61082194666;65470.01794973079;65820;65850.67074664596;66782.33217667858;69381;8286.917130828615;8460.873086903579;8487.193716596914;8492.108328625405;8508.829823403621;37870.31344499624;40601.79699101485;47728.761356193;47915.56253312406;48007.27989080236;64378;64977.67511162603;65153.348466516625;65171;65859.35351616057;10638.14894808429;10680.83978740335;10722.195835312226;10760.246782725135;11088.112950964065;11728.648140555797;11771.941140294244;12005.879941200825;12111.576094836639;12139.5690572942;10686.57253709874;10934.125269978224;11554.537818487166;11685.941570292434;12048.939755301168;9723.513824308899;11191.32852028881;11279.154063445438;11497.655070347902;11552.133589980616;10931.370344272866;10954.507047182737;11129.888701113208;11352.666640073292;11682.649520514398;9009.144131307516;9185.357025008452;9207.447553146565;9417.576209070745;9420.293477989042;8459.450135741403;9034.367594268339;9392;9477.573509191965;9486.905130948602 21:42:21 INFO - PROCESS | 1675 | __end_tp_report 21:42:21 INFO - PROCESS | 1675 | __start_cc_report 21:42:21 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,372 21:42:21 INFO - PROCESS | 1675 | __end_cc_report 21:42:21 INFO - PROCESS | 1675 | __startTimestamp1457761341084__endTimestamp 21:42:21 INFO - PROCESS | 1675 | 21:42:21 INFO - PROCESS | 1675 | ------- Summary: start ------- 21:42:21 INFO - PROCESS | 1675 | Number of tests: 6 21:42:21 INFO - PROCESS | 1675 | 21:42:21 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5717.67 Median:5978.31 stddev:646.79 (10.8%) stddev-sans-first:619.41 21:42:21 INFO - PROCESS | 1675 | Values: 3261.8 3469.6 3526.9 3529.9 3572.4 4736.5 5045.3 5713.5 5723.5 5795.0 5616.0 5748.5 5749.5 5757.2 5908.4 5059.7 5099.8 5136.1 5216.6 5290.2 5217.2 5245.2 5260.7 5278.1 5291.3 5102.1 5106.1 5189.0 5210.7 5223.5 4395.6 4958.2 5218.0 5230.9 5242.3 5036.2 5133.8 5153.0 5177.7 5179.8 5558.2 5659.3 5676.0 5682.2 5721.0 6151.1 6173.6 6225.7 6226.4 6246.9 6097.3 6193.7 6219.3 6226.7 6230.8 5885.9 5911.7 5923.1 5927.2 5945.7 5201.2 6226.5 6277.2 6285.8 6298.7 6061.2 6112.5 6129.6 6135.6 6181.5 6114.6 6139.0 6207.7 6208.0 6252.8 6134.2 6175.9 6239.5 6245.3 6252.3 6131.8 6158.5 6172.4 6186.3 6218.6 4826.6 4867.4 4888.6 4891.8 4916.8 4389.8 4402.0 4425.3 4435.4 4462.9 5726.3 5839.0 5854.3 5857.2 5944.5 6212.7 6230.9 6249.8 6250.1 6253.3 5655.3 5776.1 5933.4 5935.8 5943.3 5329.4 5338.0 5369.4 5384.2 5417.7 6344.4 6354.4 6354.9 6358.9 6377.2 6163.9 6226.9 6250.2 6261.6 6271.2 6153.0 6223.8 6281.1 6349.9 6362.4 5582.8 6182.7 6192.8 6196.7 6209.8 5161.7 5582.7 6237.3 6240.1 6359.3 6014.3 6037.1 6107.2 6148.8 6180.5 6081.0 6104.0 6114.6 6122.8 6128.5 5835.5 5837.3 5978.3 6003.0 6032.5 5178.7 6118.6 6122.8 6138.9 6173.6 6001.2 6042.3 6046.0 6064.2 6082.0 21:42:21 INFO - PROCESS | 1675 | 21:42:21 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:66835.31 Median:39205.71 stddev:138114.28 (352.3%) stddev-sans-first:138411.80 21:42:21 INFO - PROCESS | 1675 | Values: 453.7 563.1 568.9 573.6 638.1 31657.2 38596.0 38659.6 38804.4 39773.6 42141.0 42456.6 42921.1 42978.6 42985.9 9578.8 9716.9 9819.0 9828.6 9891.7 9705.1 9725.4 9780.4 9810.5 9815.5 9708.6 9763.7 9811.2 9824.3 9832.9 9746.8 9800.4 9800.7 9827.1 9832.5 9703.6 9799.2 9820.0 9839.2 9850.4 39671.2 39816.6 39952.2 39973.6 40278.6 2637.5 2688.3 3151.8 3549.4 4023.6 27368.0 27372.6 27634.4 27858.2 28154.0 2698.6 2728.9 2753.1 2767.5 2837.5 407058.0 548086.0 548756.0 553097.0 555251.0 70988.6 71618.0 72583.3 72700.6 72830.0 74002.5 76064.0 76620.0 76707.0 77250.6 17016.0 17260.8 17283.3 17416.9 17420.4 13124.9 13134.1 13197.4 13210.7 13222.5 22143.7 22288.8 22464.9 22541.9 22551.9 7590.9 8211.8 9315.2 9773.9 9885.5 760.8 813.6 1016.5 1053.6 1111.7 29755.9 29898.0 30006.4 30456.5 31164.9 1058.5 1074.7 1086.5 1140.7 1191.0 13050.6 15190.0 15237.6 15445.8 15535.5 528999.0 530092.0 534028.0 537090.0 537519.0 60505.7 60688.7 60852.0 61337.0 61629.7 1423.3 1432.2 1474.2 1477.9 1492.8 29234.6 29659.0 29782.8 29930.8 30151.0 53610.7 54076.7 54077.6 54124.6 54274.5 494320.0 495669.0 497480.0 498464.0 499093.5 32913.5 33902.7 34208.8 34262.7 34307.7 36641.8 45492.5 45738.0 46207.8 46538.3 37296.8 38312.4 38380.4 39121.4 39290.0 36794.1 37219.1 37922.0 38206.0 38262.0 31279.8 34185.0 36758.3 37144.0 37216.9 31298.4 31349.7 32300.0 32536.8 32559.5 24422.4 24495.4 24581.4 24924.5 25258.4 21:42:21 INFO - PROCESS | 1675 | 21:42:21 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:33387.53 Median:20917.19 stddev:103209.26 (493.4%) stddev-sans-first:103468.99 21:42:21 INFO - PROCESS | 1675 | Values: 356.1 364.4 369.1 371.5 372.5 16325.2 16728.7 16976.0 20902.5 20931.9 16396.4 19889.0 20051.2 20446.2 20586.4 4870.0 6046.2 6071.1 6072.8 6073.1 4275.3 5947.3 6371.5 6618.3 6645.3 6511.9 6586.3 6587.2 6588.5 6608.9 6382.3 6549.6 6551.7 6561.5 6575.9 5345.6 5631.5 5641.4 5642.9 5644.5 13249.0 13298.5 13542.9 13573.6 13599.3 2019.6 2065.9 2074.1 2109.2 2196.6 9957.5 10002.6 10046.6 10074.4 10149.2 1733.1 1760.5 1767.1 1779.9 1794.0 73412.6 97713.5 99135.0 99689.0 100746.5 8663.7 10658.2 10845.8 10889.8 10899.3 12747.8 12757.4 12759.4 12760.2 12808.6 8288.9 8422.6 8490.7 8559.0 8564.4 7381.4 8774.5 8830.6 8865.1 8874.4 4177.2 4194.0 4217.3 4224.3 4257.4 1800.3 1853.5 1902.6 1910.3 1928.6 783.2 942.4 1014.0 1019.5 1025.8 19178.4 20088.0 20322.4 20450.5 20568.4 788.8 909.0 917.2 946.8 948.1 10591.7 10942.9 10960.9 10969.2 10975.9 527490.0 616807.9 633839.0 657796.0 676340.0 108036.5 116299.4 117039.0 118370.0 118683.8 986.3 1016.6 1027.9 1030.0 1039.4 14972.5 15450.5 16638.3 17445.3 17893.6 34551.3 38801.6 40682.0 52475.7 55215.9 48771.8 58565.8 65137.0 66231.7 66518.3 7535.7 7700.7 7806.3 7881.9 8081.6 9009.5 11766.2 11780.8 11847.3 12489.3 10970.8 11125.5 11139.4 11192.8 11316.8 10737.5 10890.4 11059.8 11081.9 11213.8 11239.7 11250.3 11278.0 11561.2 11648.1 7841.5 7855.1 8018.4 8049.2 8198.8 9589.3 11085.6 11109.8 11150.8 11490.9 21:42:21 INFO - PROCESS | 1675 | 21:42:21 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:6255.48 Median:2784.66 stddev:3344.23 (120.1%) stddev-sans-first:3333.92 21:42:21 INFO - PROCESS | 1675 | Values: 1428.4 1594.6 1804.2 1876.5 2020.4 8134.0 8764.3 8906.6 9155.3 9193.2 8855.9 8903.6 8917.1 8938.6 8990.1 2177.7 2333.6 2337.5 2339.6 2340.1 2455.5 2491.9 2514.6 2520.2 2525.5 2502.0 2504.8 2522.9 2525.3 2550.0 2498.5 2515.9 2516.8 2535.1 2544.9 2103.6 2531.0 2536.3 2538.1 2546.1 9062.1 9083.2 9107.4 9124.6 9139.3 5521.1 5541.2 5582.7 5685.8 5703.2 3674.9 3736.9 3787.3 3818.2 3829.7 1049.4 1068.1 1070.0 1081.0 1097.1 12163.6 12325.4 12347.8 12362.9 12383.7 4995.7 5008.6 5103.4 5114.9 5130.9 10433.9 10434.7 10494.0 10525.2 10544.1 5682.5 5711.8 5716.1 5716.7 5734.7 4374.0 4482.9 4944.8 5063.3 5146.9 4050.6 4079.1 4112.1 4121.5 4126.7 1341.6 1355.1 1359.0 1362.6 1364.4 1349.6 1369.8 1395.4 1398.6 1411.7 7093.5 7315.5 8396.2 8542.0 8563.4 464.5 494.9 497.2 506.1 512.7 6279.6 6315.2 6327.8 6348.8 6368.6 10898.4 11198.4 11263.2 11264.5 11355.7 10704.3 11091.6 11105.8 11155.7 11161.5 8542.8 8543.0 8608.3 8666.8 8673.5 8203.7 8222.0 8225.7 8504.6 8538.0 9706.7 9905.6 9991.3 10021.2 10224.2 10133.3 10319.3 10350.4 10362.2 10459.5 7804.3 7804.6 7851.0 7861.3 7923.4 8480.7 8590.4 8592.2 8620.8 8621.5 7501.1 7693.1 7741.5 7778.3 7840.7 7511.5 7598.6 7627.5 7740.8 7751.5 7935.9 8011.7 8060.3 8119.7 8128.9 7003.8 7179.3 7184.3 7239.5 7298.2 7277.6 7316.8 7321.2 7326.8 7327.0 21:42:21 INFO - PROCESS | 1675 | 21:42:21 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:5897.84 Median:6768.18 stddev:1961.32 (29.0%) stddev-sans-first:1921.71 21:42:21 INFO - PROCESS | 1675 | Values: 325.5 327.0 330.9 334.6 335.0 6772.4 6797.2 6811.6 6836.2 6866.7 6721.7 6764.0 6774.3 6787.3 6798.7 4745.5 4822.7 4938.9 4957.7 4976.9 3819.0 4367.7 4939.3 4946.8 4990.4 4263.6 4819.3 4866.3 4908.5 4927.0 3793.4 4298.5 4616.8 4880.0 4922.4 4213.8 4253.5 4254.5 4267.6 4278.5 4981.4 5266.6 6583.0 6584.8 6592.9 5811.8 5837.4 5858.6 5875.7 5903.6 6061.0 7184.6 7225.7 7295.1 7307.3 3897.9 4287.5 4447.5 4657.5 4676.3 7621.8 7627.2 7643.2 7678.4 7691.5 4521.5 4710.2 4727.7 4728.4 4728.6 4799.9 4807.4 4849.9 4859.3 4862.7 4916.7 5705.2 5812.1 5818.5 5830.4 7308.7 7313.8 7314.7 7329.4 7463.9 1642.9 1675.2 1677.9 1679.9 1684.7 1026.5 1060.6 1063.0 1067.1 1081.4 6719.4 6725.3 6804.9 6820.0 6834.6 7578.0 7586.7 7592.2 7603.0 7632.7 6568.3 6689.5 6829.8 6837.3 6866.2 3974.9 4003.6 4013.7 4029.1 4052.9 7908.9 7931.1 7939.0 7949.2 7965.4 7511.1 7853.1 7866.5 7867.1 7878.2 7893.0 7901.2 7925.3 7939.1 7945.7 6191.3 7646.4 7660.3 7661.3 7666.9 7471.2 7475.4 7479.0 7491.6 7516.7 7627.6 7924.4 7934.8 7935.2 7939.4 3456.9 4722.7 4783.5 4791.4 4801.9 7608.7 7630.3 7647.3 7650.8 7655.2 7369.7 7372.4 7378.7 7380.7 7439.7 7119.7 7339.9 7371.5 7404.4 7406.0 5885.8 6948.5 7197.2 7204.1 7216.8 6392.8 6990.0 7355.3 7361.8 7378.0 5713.7 7148.8 7155.9 7159.4 7196.6 21:42:21 INFO - PROCESS | 1675 | 21:42:21 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:17712.54 Median:65162.17 stddev:24481.83 (37.6%) stddev-sans-first:24517.10 21:42:21 INFO - PROCESS | 1675 | Values: 678.4 707.1 737.7 761.3 781.3 14883.2 15045.7 15264.1 15271.9 15273.8 14059.1 14102.4 14151.0 14158.9 14185.6 714.2 895.3 913.9 941.8 945.1 848.7 910.8 923.7 929.5 932.1 969.8 971.6 978.6 979.3 980.9 775.7 794.3 896.2 955.3 970.4 694.9 709.0 717.4 719.3 729.8 14672.1 14930.1 14977.5 15019.9 15078.6 12964.9 13212.9 13248.3 13291.3 13322.1 8396.6 9691.2 9943.7 10096.5 10144.6 3444.2 3488.5 3488.9 3512.4 3519.3 80500.0 80523.6 80812.2 81033.0 81039.0 9376.2 9717.8 9760.4 9845.2 10017.6 22547.8 22958.0 22983.2 23041.0 23042.9 7519.7 7564.7 7587.3 7727.7 8030.0 3840.1 3844.1 3855.5 3873.3 3992.0 3623.9 3636.8 3656.4 3678.7 3692.8 642.6 656.9 662.5 668.8 673.8 520.6 555.7 577.4 579.3 608.1 7755.9 8049.8 8077.0 8083.9 8147.8 498.0 568.6 575.2 602.4 629.3 3725.9 3795.6 3849.0 3857.0 3862.0 71042.0 73536.6 90689.5 90690.0 90985.5 74994.0 76644.0 77164.8 77684.0 77835.6 65470.0 65820.0 65850.7 66782.3 69381.0 8286.9 8460.9 8487.2 8492.1 8508.8 37870.3 40601.8 47728.8 47915.6 48007.3 64378.0 64977.7 65153.3 65171.0 65859.4 10638.1 10680.8 10722.2 10760.2 11088.1 11728.6 11771.9 12005.9 12111.6 12139.6 10686.6 10934.1 11554.5 11685.9 12048.9 9723.5 11191.3 11279.2 11497.7 11552.1 10931.4 10954.5 11129.9 11352.7 11682.6 9009.1 9185.4 9207.4 9417.6 9420.3 8459.5 9034.4 9392.0 9477.6 9486.9 21:42:21 INFO - PROCESS | 1675 | -------- Summary: end -------- 21:42:21 INFO - PROCESS | 1675 | 21:42:21 INFO - TEST-INFO | 1675: exit 0 21:42:21 INFO - TEST-OK | dromaeo_css | took 1111131ms 21:42:21 INFO - TEST-START | kraken 21:42:21 INFO - operating with platform_type : mac_ 21:42:21 INFO - Initialising browser for kraken test... 21:42:21 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/tmpMUDm7b/profile http://localhost:49270/getInfo.html) 21:42:24 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 21:42:24 INFO - PROCESS | 1683 | colorDepth:24 21:42:24 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 21:42:24 INFO - PROCESS | 1683 | __metrics 21:42:24 ERROR - PROCESS | 1683 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 21:42:25 INFO - TEST-INFO | 1683: exit 0 21:42:25 INFO - Browser initialized. 21:42:25 INFO - Running cycle 1/1 for kraken test... 21:42:25 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/tmpMUDm7b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:37 INFO - PROCESS | 1686 | RSS: Main: 256561152 21:42:37 INFO - PROCESS | 1686 | 21:42:40 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 21:42:40 INFO - PROCESS | 1686 | RSS: Main: 268337152 21:42:40 INFO - PROCESS | 1686 | 21:42:43 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 21:42:44 INFO - PROCESS | 1686 | RSS: Main: 276480000 21:42:44 INFO - PROCESS | 1686 | 21:42:47 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 21:42:48 INFO - PROCESS | 1686 | RSS: Main: 281559040 21:42:48 INFO - PROCESS | 1686 | 21:42:50 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 21:42:50 INFO - PROCESS | 1686 | RSS: Main: 282783744 21:42:50 INFO - PROCESS | 1686 | 21:42:52 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:42:53 INFO - PROCESS | 1686 | RSS: Main: 283488256 21:42:53 INFO - PROCESS | 1686 | 21:42:56 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 21:42:57 INFO - PROCESS | 1686 | RSS: Main: 283537408 21:42:57 INFO - PROCESS | 1686 | 21:43:00 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 21:43:00 INFO - PROCESS | 1686 | RSS: Main: 283340800 21:43:00 INFO - PROCESS | 1686 | 21:43:03 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 21:43:04 INFO - PROCESS | 1686 | RSS: Main: 283484160 21:43:04 INFO - PROCESS | 1686 | 21:43:05 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:43:06 INFO - PROCESS | 1686 | RSS: Main: 283959296 21:43:06 INFO - PROCESS | 1686 | 21:43:08 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:43:09 INFO - PROCESS | 1686 | RSS: Main: 282255360 21:43:09 INFO - PROCESS | 1686 | 21:43:11 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:43:11 INFO - PROCESS | 1686 | RSS: Main: 284270592 21:43:11 INFO - PROCESS | 1686 | 21:43:14 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:43:14 INFO - PROCESS | 1686 | RSS: Main: 283832320 21:43:14 INFO - PROCESS | 1686 | 21:43:17 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:43:18 INFO - PROCESS | 1686 | RSS: Main: 284356608 21:43:18 INFO - PROCESS | 1686 | 21:43:19 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 21:43:20 INFO - PROCESS | 1686 | RSS: Main: 285835264 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | __start_tp_report 21:43:20 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 21:43:20 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 21:43:20 INFO - PROCESS | 1686 | |i|pagename|runs| 21:43:20 INFO - PROCESS | 1686 | |0;ai-astar;114;108;116;116;116;130;112;104;140;169 21:43:20 INFO - PROCESS | 1686 | |1;audio-beat-detection;152;125;177;153;149;172;165;153;189;143 21:43:20 INFO - PROCESS | 1686 | |2;audio-dft;238;248;209;228;200;202;211;244;202;199 21:43:20 INFO - PROCESS | 1686 | |3;audio-fft;79;68;76;137;61;79;87;81;137;58 21:43:20 INFO - PROCESS | 1686 | |4;audio-oscillator;83;89;126;78;80;82;118;79;80;117 21:43:20 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;94;76;135;127;92;89;92;89;92;89 21:43:20 INFO - PROCESS | 1686 | |6;imaging-darkroom;148;151;97;97;97;143;138;97;104;98 21:43:20 INFO - PROCESS | 1686 | |7;imaging-desaturate;95;96;93;130;142;109;149;144;102;90 21:43:20 INFO - PROCESS | 1686 | |8;json-parse-financial;56;55;57;54;56;56;57;58;79;86 21:43:20 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;62;66;72;66;72;73;70;68;65;69 21:43:20 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;85;83;85;85;84;89;84;84;87;86 21:43:20 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;134;137;133;114;134;130;136;135;128;124 21:43:20 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;130;142;139;143;144;137;138;180;189;145 21:43:20 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;71;88;98;91;96;90;75;67;69;67 21:43:20 INFO - PROCESS | 1686 | __end_tp_report 21:43:20 INFO - PROCESS | 1686 | __start_cc_report 21:43:20 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,940 21:43:20 INFO - PROCESS | 1686 | __end_cc_report 21:43:20 INFO - PROCESS | 1686 | __startTimestamp1457761400244__endTimestamp 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | ------- Summary: start ------- 21:43:20 INFO - PROCESS | 1686 | Number of tests: 14 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:122.50 Median:116.00 stddev:19.40 (16.7%) stddev-sans-first:20.33 21:43:20 INFO - PROCESS | 1686 | Values: 114.0 108.0 116.0 116.0 116.0 130.0 112.0 104.0 140.0 169.0 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:157.80 Median:159.00 stddev:18.40 (11.6%) stddev-sans-first:19.40 21:43:20 INFO - PROCESS | 1686 | Values: 152.0 125.0 177.0 153.0 149.0 172.0 165.0 153.0 189.0 143.0 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:218.10 Median:219.50 stddev:19.44 (8.9%) stddev-sans-first:19.24 21:43:20 INFO - PROCESS | 1686 | Values: 238.0 248.0 209.0 228.0 200.0 202.0 211.0 244.0 202.0 199.0 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:86.30 Median:77.50 stddev:28.20 (36.4%) stddev-sans-first:29.79 21:43:20 INFO - PROCESS | 1686 | Values: 79.0 68.0 76.0 137.0 61.0 79.0 87.0 81.0 137.0 58.0 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:80.00 stddev:19.11 (23.9%) stddev-sans-first:19.91 21:43:20 INFO - PROCESS | 1686 | Values: 83.0 89.0 126.0 78.0 80.0 82.0 118.0 79.0 80.0 117.0 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:97.50 Median:90.50 stddev:18.43 (20.4%) stddev-sans-first:19.51 21:43:20 INFO - PROCESS | 1686 | Values: 94.0 76.0 135.0 127.0 92.0 89.0 92.0 89.0 92.0 89.0 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:117.00 Median:97.00 stddev:24.41 (25.2%) stddev-sans-first:23.17 21:43:20 INFO - PROCESS | 1686 | Values: 148.0 151.0 97.0 97.0 97.0 143.0 138.0 97.0 104.0 98.0 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:115.00 Median:119.50 stddev:23.63 (19.8%) stddev-sans-first:23.93 21:43:20 INFO - PROCESS | 1686 | Values: 95.0 96.0 93.0 130.0 142.0 109.0 149.0 144.0 102.0 90.0 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:57.00 stddev:11.30 (19.8%) stddev-sans-first:11.81 21:43:20 INFO - PROCESS | 1686 | Values: 56.0 55.0 57.0 54.0 56.0 56.0 57.0 58.0 79.0 86.0 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:69.50 stddev:3.56 (5.1%) stddev-sans-first:2.96 21:43:20 INFO - PROCESS | 1686 | Values: 62.0 66.0 72.0 66.0 72.0 73.0 70.0 68.0 65.0 69.0 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:1.75 (2.1%) stddev-sans-first:1.86 21:43:20 INFO - PROCESS | 1686 | Values: 85.0 83.0 85.0 85.0 84.0 89.0 84.0 84.0 87.0 86.0 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:134.00 stddev:7.03 (5.2%) stddev-sans-first:7.34 21:43:20 INFO - PROCESS | 1686 | Values: 134.0 137.0 133.0 114.0 134.0 130.0 136.0 135.0 128.0 124.0 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:143.50 stddev:19.47 (13.6%) stddev-sans-first:19.44 21:43:20 INFO - PROCESS | 1686 | Values: 130.0 142.0 139.0 143.0 144.0 137.0 138.0 180.0 189.0 145.0 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.20 Median:89.00 stddev:12.54 (14.1%) stddev-sans-first:12.75 21:43:20 INFO - PROCESS | 1686 | Values: 71.0 88.0 98.0 91.0 96.0 90.0 75.0 67.0 69.0 67.0 21:43:20 INFO - PROCESS | 1686 | -------- Summary: end -------- 21:43:20 INFO - PROCESS | 1686 | 21:43:20 INFO - TEST-INFO | 1686: exit 0 21:43:20 INFO - TEST-OK | kraken | took 59363ms 21:43:20 INFO - SUITE-END | took 1170s 21:43:21 INFO - Completed test suite (00:19:30) 21:43:21 INFO - javascript benchmark 21:43:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3261.842046073644, 3469.6356882527334, 3526.8765593204234, 3529.8764543240977, 3572.3748344039786, 4736.526347365262, 5045.318881950945, 5713.5143512801405, 5723.54211663067, 5794.971025144879, 5616.0, 5748.482636562709, 5749.511291540213, 5757.165211044396, 5908.40915908409, 5059.721715305656, 5099.7705103270255, 5136.101182293102, 5216.582673386139, 5290.1800220965815, 5217.191335343009, 5245.239440281157, 5260.684358938476, 5278.102722537159, 5291.259223708684, 5102.132637451624, 5106.055379754739, 5189.0, 5210.6613070150315, 5223.477652234784, 4395.63735242076, 4958.231474121517, 5218.0, 5230.92153617696, 5242.344706911636, 5036.169032109698, 5133.768980395891, 5153.0, 5177.663451875616, 5179.7928082877015, 5558.249636299129, 5659.320881494205, 5675.971620141873, 5682.17608446777, 5721.0, 6151.138840562325, 6173.567850250484, 6225.657588832612, 6226.377362263783, 6246.906296405557, 6097.252466530076, 6193.668361302297, 6219.2847822500535, 6226.719797609118, 6230.781922632731, 5885.941140588625, 5911.733971971272, 5923.111533270044, 5927.199828023205, 5945.672987985659, 5201.245819356248, 6226.501879849601, 6277.246730392382, 6285.842853928689, 6298.685065746694, 6061.151348838646, 6112.473085128069, 6129.570930034944, 6135.631862088199, 6181.474574661114, 6114.60152118864, 6139.001538246403, 6207.689615519206, 6207.96896015517, 6252.843678908063, 6134.171886795226, 6175.876482470326, 6239.469645080219, 6245.313015568284, 6252.280987686474, 6131.835460087213, 6158.538109641795, 6172.444479996821, 6186.319504854462, 6218.595791273643, 4826.638002149853, 4867.367242258484, 4888.633352498577, 4891.755412229374, 4916.754162291871, 4389.846355377546, 4402.031553058322, 4425.3140763181755, 4435.423394958635, 4462.866114016585, 5726.3128424588485, 5839.0, 5854.326752423441, 5857.179994800731, 5944.494717949023, 6212.689365531705, 6230.875382492325, 6249.812505624838, 6250.124982502453, 6253.343398943137, 5655.293088363955, 5776.133579962955, 5933.406659334119, 5935.792247271324, 5943.286805583358, 5329.413764485904, 5338.0, 5369.382521010056, 5384.246205531229, 5417.674939503642, 6344.365563443711, 6354.3963323484195, 6354.90467642995, 6358.904616430757, 6377.23473183221, 6163.9383606163365, 6226.906596400967, 6250.249970003629, 6261.5616906816085, 6271.184745983175, 6153.046277826944, 6223.844403889939, 6281.057841323838, 6349.936500635119, 6362.363763623601, 5582.827606202581, 6182.6599537025895, 6192.845178870564, 6196.721147548461, 6209.751609935552, 5161.741912904415, 5582.665040097607, 6237.345078766845, 6240.126382306572, 6359.268684101387, 6014.338422773404, 6037.09443583466, 6107.158472117419, 6148.754049838135, 6180.536459765445, 6081.0, 6104.0, 6114.57197996136, 6122.755089796358, 6128.479079278133, 5835.503982161564, 5837.29952405714, 5978.312494063239, 6002.969985150046, 6032.517398608188, 5178.663386879841, 6118.60229085108, 6122.846928826815, 6138.878900475427, 6173.56785025044, 6001.189839371804, 6042.335343112166, 6046.0, 6064.181335519648, 6082.0], "unit": "score", "name": "dojo.html", "value": 5678.149004641896}, {"lowerIsBetter": false, "replicates": [453.6801554903791, 563.0962305499676, 568.9474472226382, 573.6414740787009, 638.0907207229698, 31657.208569785766, 38596.0, 38659.61340386595, 38804.41793373102, 39773.60226397735, 42141.0, 42456.57543424565, 42921.14157716851, 42978.57021429785, 42985.925351866215, 9578.760530986712, 9716.854247186298, 9819.0, 9828.55771490281, 9891.703248902508, 9705.126538611523, 9725.416475011487, 9780.413175209475, 9810.46042467664, 9815.4601496918, 9708.563114659823, 9763.658271960483, 9811.215102791759, 9824.263180261472, 9832.90167098327, 9746.756331091745, 9800.411975281435, 9800.705978820612, 9827.11555959967, 9832.508374581243, 9703.563339649732, 9799.216062714966, 9820.0, 9839.212862971017, 9850.408975461496, 39671.20657586861, 39816.60183398187, 39952.20095598101, 39973.60026399728, 40278.59721402778, 2637.5384307746067, 2688.2876037849987, 3151.7636177286795, 3549.4143466328023, 4023.5515214522748, 27368.042118525755, 27372.58941115885, 27634.447311053867, 27858.16425507238, 28154.0, 2698.608701738237, 2728.945421091587, 2753.1190019193864, 2767.529519981608, 2837.531807251801, 407057.96471017454, 548086.0, 548756.0, 553097.0, 555251.0, 70988.64505677439, 71617.98674092763, 72583.27416725871, 72700.63649681823, 72830.0, 74002.51994960071, 76064.0, 76620.0, 76707.0, 77250.6137469309, 17016.0, 17260.827391726172, 17283.308667653153, 17416.912915435594, 17420.39028634017, 13124.884384827206, 13134.146280491737, 13197.406116724771, 13210.669733256553, 13222.471101156038, 22143.667844982338, 22288.77711222867, 22464.887675561844, 22541.88729056344, 22551.887240563694, 7590.8861367079535, 8211.794705132419, 9315.161635452841, 9773.9022609773, 9885.505724713736, 760.8017372638117, 813.6135335715488, 1016.4561959351711, 1053.5724093852873, 1111.6665000499818, 29755.85122074419, 29898.0, 30006.448806970344, 30456.54315185274, 31164.909228176904, 1058.5183741397645, 1074.7044562745307, 1086.4947799273375, 1140.669205930271, 1190.9940450297693, 13050.608481745563, 15190.0, 15237.6190595236, 15445.768313475306, 15535.45625903088, 528999.0, 530092.0, 534028.0, 537090.0, 537519.0, 60505.69747151236, 60688.69655651694, 60852.0, 61337.0, 61629.691851540454, 1423.3239211374514, 1432.2122832442324, 1474.1965628732366, 1477.8596033376812, 1492.7910092587047, 29234.56148157737, 29659.0, 29782.822165398058, 29930.802767889913, 30151.0, 53610.73194634002, 54076.729616351666, 54077.64805879885, 54124.646883826645, 54274.45725542852, 494320.0, 495669.0, 497480.0, 498464.0, 499093.504532475, 32913.50629740508, 33902.66097338995, 34208.82895585506, 34262.65737342694, 34307.65692343045, 36641.81679091587, 45492.545074548834, 45738.0, 46207.84480388017, 46538.30192547047, 37296.81351593225, 38312.42531361976, 38380.42429363618, 39121.41317880177, 39290.0, 36794.080147996516, 37219.06952326214, 37922.0, 38206.0, 38262.043448914, 31279.84360078185, 34185.0, 36758.26483470369, 37144.0, 37216.883493494155, 31298.374032519678, 31349.733047253496, 32300.0, 32536.83731581327, 32559.51160732638, 24422.35975164713, 24495.38761530976, 24581.38546536351, 24924.50150997006, 25258.36854078663], "unit": "score", "name": "ext.html", "value": 20280.734152126333}, {"lowerIsBetter": false, "replicates": [356.1292639496431, 364.4060181903497, 369.12149085177276, 371.5244487056569, 372.5231703419624, 16325.183740812956, 16728.665426691474, 16975.981441113527, 20902.477438064056, 20931.895340523315, 16396.426125085625, 19889.0, 20051.1979520819, 20446.18215271391, 20586.42669666292, 4869.951300487003, 6046.1837651917085, 6071.058985857199, 6072.757089716406, 6073.119397687333, 4275.315949448089, 5947.316058653245, 6371.490280777527, 6618.271990081087, 6645.269020407752, 6511.9348806512035, 6586.308437614053, 6587.242467116271, 6588.472922166239, 6608.9339106608795, 6382.266039405481, 6549.574277671936, 6551.705173267214, 6561.540692151551, 6575.901361479581, 5345.572354211654, 5631.549476041907, 5641.435856414326, 5642.858928526779, 5644.463775941279, 13248.987702646637, 13298.534551290755, 13542.86457135426, 13573.574774648718, 13599.320033998261, 2019.5657933544358, 2065.917363305466, 2074.097767471155, 2109.177420805887, 2196.560687862434, 9957.5021248938, 10002.649907253211, 10046.598136074548, 10074.395536267773, 10149.238807089498, 1733.0641453615033, 1760.5070580237555, 1767.1164417791103, 1779.851995462932, 1793.9910300448414, 73412.63293683551, 97713.51143244309, 99135.0, 99689.0, 100746.49626751893, 8663.740087797376, 10658.200634952409, 10845.83731244032, 10889.83665245022, 10899.29154604948, 12747.808782868078, 12757.42591583381, 12759.42582583786, 12760.170588911877, 12808.551700690432, 8288.917110828814, 8422.578871056423, 8490.660373585111, 8558.95720521406, 8564.443311184878, 7381.386633354154, 8774.517401542977, 8830.602622881986, 8865.113488651083, 8874.423162494417, 4177.248095342868, 4193.979030104891, 4217.261979153636, 4224.324108142682, 4257.425247591597, 1800.324878170686, 1853.4532312967706, 1902.6289873474816, 1910.2931915191468, 1928.5660726336462, 783.2167832167833, 942.3827393057559, 1013.9695809125591, 1019.5106348952544, 1025.7999690060367, 19178.424647260603, 20088.0, 20322.390328290174, 20450.488737781674, 20568.382948511568, 788.7949133225288, 909.0093592082108, 917.1516347378648, 946.8106378724283, 948.0708905272734, 10591.682249532527, 10942.945285273681, 10960.890391096147, 10969.229847646862, 10975.945120274508, 527490.0, 616807.9159604174, 633839.0, 657796.0, 676340.0, 108036.45981770198, 116299.41850290695, 117039.0, 118370.0, 118683.81316186901, 986.2898712926682, 1016.5628779624684, 1027.9383237005804, 1029.9588016479406, 1039.4335087377397, 14972.47596334123, 15450.5364839055, 16638.3344666212, 17445.30218791234, 17893.552661183574, 34551.30897381988, 38801.61198388093, 40682.0, 52475.73762131165, 55215.89568208533, 48771.75614121907, 58565.828683426946, 65137.0, 66231.67536649144, 66518.3370415724, 7535.660895259617, 7700.730474433368, 7806.297433231037, 7881.881771773543, 8081.595920204084, 9009.459432434074, 11766.176367654181, 11780.76438471243, 11847.289162650268, 12489.31308778026, 10970.835437468284, 11125.499352528994, 11139.443027848738, 11192.776144477228, 11316.830247546459, 10737.46312684347, 10890.401027943539, 11059.834102488308, 11081.944590276997, 11213.831792523282, 11239.719007024889, 11250.324980501196, 11278.0, 11561.190716649753, 11648.126390520576, 7841.529508229524, 7855.057393112635, 8018.398620103399, 8049.235322644339, 8198.836023279382, 9589.34804583068, 11085.556577736801, 11109.777804444027, 11150.832737509107, 11490.88509114898], "unit": "score", "name": "jquery.html", "value": 9038.757369468747}, {"lowerIsBetter": false, "replicates": [1428.3929330034737, 1594.6013496625847, 1804.2332008896217, 1876.4558278099353, 2020.444377796105, 8133.959330203355, 8764.25503832175, 8906.554672266393, 9155.267578593714, 9193.172614464705, 8855.91144088559, 8903.643854245822, 8917.063708310632, 8938.642454301837, 8990.145936136056, 2177.7060096886876, 2333.603287441139, 2337.4623836517612, 2339.63735620979, 2340.1224540797202, 2455.4966231922504, 2491.9003239870385, 2514.5976643737004, 2520.231329444519, 2525.532776436356, 2502.0, 2504.8371855829405, 2522.8738563071865, 2525.267672375009, 2549.9745002550017, 2498.475320182764, 2515.9119430819924, 2516.7609077137645, 2535.1380530619494, 2544.860032698201, 2103.6423807952683, 2531.0255551612577, 2536.2771610091036, 2538.0609174605515, 2546.0579585553464, 9062.139096785795, 9083.182513573744, 9107.408018478844, 9124.635014599407, 9139.26885849137, 5521.089020311644, 5541.196526503675, 5582.692951887685, 5685.800996965087, 5703.17303990919, 3674.9448758268645, 3736.8878933631763, 3787.2993496203017, 3818.16000479894, 3829.655331020194, 1049.375621505203, 1068.1027936533349, 1069.9625513107003, 1080.9568766140633, 1097.13874608432, 12163.635090947286, 12325.383730813424, 12347.814782778265, 12362.876371236352, 12383.690407739788, 4995.725235112103, 5008.64939454242, 5103.413107492612, 5114.872128196825, 5130.871728206825, 10433.895661043443, 10434.739131521621, 10494.003069708366, 10525.21060920434, 10544.103751181083, 5682.460166284196, 5711.828645140652, 5716.142578613241, 5716.685582292931, 5734.655920644775, 4373.978130109329, 4482.932756008662, 4944.826931057396, 5063.265826455144, 5146.922796158061, 4050.563690426754, 4079.0618157823865, 4112.115895082572, 4121.4848143982, 4126.690498212646, 1341.5774031180342, 1355.098859258582, 1358.9864101359058, 1362.5776009436909, 1364.40648317982, 1349.5990104935508, 1369.7671395862728, 1395.386030146732, 1398.6433459467771, 1411.7176564687104, 7093.538919970186, 7315.524490908074, 8396.160383961676, 8542.0, 8563.443376180529, 464.5401052957615, 494.9109160351171, 497.1647631978311, 506.0562051773416, 512.6642049457611, 6279.591826531261, 6315.242170939425, 6327.778527751507, 6348.777792777323, 6368.554201205964, 10898.400587967737, 11198.384088875027, 11263.211575189822, 11264.493097810619, 11355.716107097389, 10704.30422022566, 11091.5563377464, 11105.777884442266, 11155.665330040112, 11161.497732602053, 8542.786430339167, 8542.957285213533, 8608.268297194683, 8666.826663466822, 8673.522956237468, 8203.71287004952, 8222.0, 8225.670973161006, 8504.574771261288, 8537.957310213409, 9706.660266890625, 9905.55425005862, 9991.300608957303, 10021.198304135798, 10224.1820654346, 10133.290669653054, 10319.277650564389, 10350.430726310125, 10362.222833287382, 10459.477026148814, 7804.2976132146105, 7804.609769511615, 7851.0, 7861.292483676497, 7923.3661307096445, 8480.703175388831, 8590.441621294596, 8592.226699596817, 8620.827583448421, 8621.482711037357, 7501.099868015873, 7693.115291741521, 7741.458097933316, 7778.299953004257, 7840.7062834633925, 7511.474196806171, 7598.620068996639, 7627.54234745917, 7740.8451830964195, 7751.496152750054, 7935.880961785462, 8011.719589814328, 8060.274575288252, 8119.675212991414, 8128.878066828884, 7003.7548685795755, 7179.282071792779, 7184.281571842774, 7239.457040722073, 7298.23368546295, 7277.59973201479, 7316.817079573053, 7321.194668586345, 7326.780196594111, 7327.0], "unit": "score", "name": "mootools.html", "value": 4990.420094233668}, {"lowerIsBetter": false, "replicates": [325.4759836662973, 327.0499199824509, 330.932158907424, 334.56506541496066, 334.9949750753738, 6772.390484856362, 6797.184337879449, 6811.625360605165, 6836.179658440988, 6866.656667166647, 6721.731130754776, 6763.9661801691045, 6774.322567743223, 6787.2873348298335, 6798.694058767355, 4745.549172828576, 4822.662413631029, 4938.876528086791, 4957.677750946177, 4976.925346119802, 3819.0261483321715, 4367.672424568154, 4939.283803848458, 4946.812764936407, 4990.351254336932, 4263.594958478955, 4819.2530157825595, 4866.343043689109, 4908.484609116027, 4927.0, 3793.412021136728, 4298.527162012176, 4616.7765542131365, 4879.999600081993, 4922.409310882681, 4213.768242746648, 4253.510846252659, 4254.468191476066, 4267.591694740728, 4278.507971583276, 4981.402231732179, 5266.552343050807, 6583.0, 6584.835379115512, 6592.86814263712, 5811.796587119473, 5837.445442682938, 5858.619189752652, 5875.735591898375, 5903.586748927577, 6060.969635161989, 7184.568925864465, 7225.747098851515, 7295.124585049775, 7307.3058059484265, 3897.8635747748694, 4287.48550173978, 4447.533009034069, 4657.534246575349, 4676.275177347517, 7621.809454763676, 7627.199144089846, 7643.235676432312, 7678.425922685836, 7691.461597688108, 4521.507902392268, 4710.24636058229, 4727.7163370197895, 4728.385309909759, 4728.59806916416, 4799.904061880137, 4807.4471435784635, 4849.903001940012, 4859.34398856157, 4862.732549709729, 4916.680415772963, 5705.229793977843, 5812.070068788974, 5818.4763371296785, 5830.3586605473365, 7308.707651693979, 7313.817154571178, 7314.6708398121145, 7329.377002954702, 7463.925360746432, 1642.884998050125, 1675.23776681612, 1677.874159438047, 1679.8908070975347, 1684.7304431290934, 1026.5431882812077, 1060.5704689600725, 1063.0379506546587, 1067.0876400677464, 1081.4376524207369, 6719.42884854783, 6725.327467253235, 6804.863902721918, 6820.0, 6834.589924604539, 7578.014858068526, 7586.658600362997, 7592.240775922474, 7603.01160849086, 7632.69469221225, 6568.310327415648, 6689.464842812563, 6829.829254268584, 6837.282085381063, 6866.244713081557, 3974.940375894364, 4003.579624139482, 4013.678905687538, 4029.0531725044593, 4052.918941621151, 7908.8813667793875, 7931.087924888597, 7939.0, 7949.165337639464, 7965.362770978308, 7511.098668159747, 7853.136155022943, 7866.528008319519, 7867.095284042294, 7878.172791856887, 7893.0, 7901.222224999329, 7925.28672419485, 7939.087004994384, 7945.721899733598, 6191.318954914866, 7646.426518011061, 7660.2722741339485, 7661.272179142972, 7666.923330766621, 7471.17817040136, 7475.439342049477, 7479.0, 7491.587962662106, 7516.699332026877, 7627.618619069135, 7924.445288829726, 7934.761957141295, 7935.246151615587, 7939.364850812037, 3456.8617255309505, 4722.669413141047, 4783.497732738151, 4791.425028996543, 4801.927971080367, 7608.695652174072, 7630.2751238632245, 7647.349975252166, 7650.770476885702, 7655.1962043986805, 7369.705211791683, 7372.373348265458, 7378.667959941923, 7380.741674041383, 7439.702411903463, 7119.715211391486, 7339.926600733925, 7371.520851144658, 7404.370628496423, 7405.96316515699, 5885.823425297248, 6948.478864085113, 7197.172325182671, 7204.0994875640545, 7216.7834964951135, 6392.776252831129, 6990.021397004525, 7355.338019578264, 7361.779146625609, 7378.040854688856, 5713.653931201492, 7148.785536433916, 7155.928440715526, 7159.355657990805, 7196.568205907663], "unit": "score", "name": "prototype.html", "value": 5243.317279098282}, {"lowerIsBetter": false, "replicates": [678.362339400963, 707.137292503146, 737.7012310014446, 761.3376362564567, 781.2539025230905, 14883.18142502162, 15045.699086018272, 15264.084154950711, 15271.923640381796, 15273.847261527395, 14059.086159399658, 14102.435902563911, 14151.0, 14158.858411415882, 14185.645358866033, 714.1822613107988, 895.2793001633698, 913.9177474027337, 941.8493041113423, 945.0785484152965, 848.6944699908029, 910.7632015675939, 923.7413524213231, 929.4748467116058, 932.0912110692055, 969.8448248280276, 971.6016433262364, 978.6379039755265, 979.2802290316647, 980.8675828763097, 775.6658547298638, 794.3486341200218, 896.1531352871539, 955.3121752338305, 970.3741086998881, 694.9061876646639, 708.950373473857, 717.4188906985358, 719.2879049740772, 729.8394353242278, 14672.119672819665, 14930.1041937483, 14977.475788347356, 15019.924900375538, 15078.623034424118, 12964.870351296555, 13212.933935330359, 13248.337583120901, 13291.268980206085, 13322.134061285986, 8396.580170991427, 9691.224702023821, 9943.701688949342, 10096.495175241282, 10144.594216231342, 3444.156181735491, 3488.5464889564446, 3488.8604455821737, 3512.438009918401, 3519.3137338218803, 80499.99999999942, 80523.59738201271, 80812.19187808105, 81033.0, 81039.0, 9376.249900007982, 9717.757056073655, 9760.365576237522, 9845.163161131384, 10017.599296028224, 22547.774522254567, 22958.0, 22983.195588154667, 23041.0, 23042.884785575963, 7519.661615227328, 7564.735234266885, 7587.279208475186, 7727.65225564851, 8029.996250468691, 3840.0975770693863, 3844.115853353688, 3855.479510266134, 3873.2640798248244, 3992.0, 3623.927521449556, 3636.8181590920876, 3656.3784156693428, 3678.7240956927803, 3692.778433294011, 642.6497558830449, 656.8620589676221, 662.4965026579738, 668.7859884836805, 673.8416472129046, 520.591335801394, 555.7165845418865, 577.3533642320627, 579.2730123694736, 608.0787606775739, 7755.883661745078, 8049.758507244792, 8076.990376202974, 8083.878741818878, 8147.75556733299, 497.9816275716097, 568.6218664588085, 575.23493753308, 602.4246844263718, 629.2826178156905, 3725.9441108382853, 3795.582485926546, 3848.9807550962064, 3856.9807150964066, 3861.995881070942, 71042.0, 73536.63231683808, 90689.54655226813, 90690.0, 90985.54507227421, 74994.0, 76644.0181388208, 77164.84252736214, 77684.0, 77835.61082194666, 65470.01794973079, 65820.0, 65850.67074664596, 66782.33217667858, 69381.0, 8286.917130828615, 8460.873086903579, 8487.193716596914, 8492.108328625405, 8508.829823403621, 37870.31344499624, 40601.79699101485, 47728.761356193, 47915.56253312406, 48007.27989080236, 64378.0, 64977.67511162603, 65153.348466516625, 65171.0, 65859.35351616057, 10638.14894808429, 10680.83978740335, 10722.195835312226, 10760.246782725135, 11088.112950964065, 11728.648140555797, 11771.941140294244, 12005.879941200825, 12111.576094836639, 12139.5690572942, 10686.57253709874, 10934.125269978224, 11554.537818487166, 11685.941570292434, 12048.939755301168, 9723.513824308899, 11191.32852028881, 11279.154063445438, 11497.655070347902, 11552.133589980616, 10931.370344272866, 10954.507047182737, 11129.888701113208, 11352.666640073292, 11682.649520514398, 9009.144131307516, 9185.357025008452, 9207.447553146565, 9417.576209070745, 9420.293477989042, 8459.450135741403, 9034.367594268339, 9392.0, 9477.573509191965, 9486.905130948602], "unit": "score", "name": "yui.html", "value": 6827.744726068652}], "name": "dromaeo_css", "value": 7555.137411519587}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 116.0, 116.0, 116.0, 130.0, 112.0, 104.0, 140.0, 169.0], "unit": "score", "name": "ai-astar", "value": 122.5}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 177.0, 153.0, 149.0, 172.0, 165.0, 153.0, 189.0, 143.0], "unit": "score", "name": "audio-beat-detection", "value": 157.8}, {"lowerIsBetter": true, "replicates": [238.0, 248.0, 209.0, 228.0, 200.0, 202.0, 211.0, 244.0, 202.0, 199.0], "unit": "score", "name": "audio-dft", "value": 218.1}, {"lowerIsBetter": true, "replicates": [79.0, 68.0, 76.0, 137.0, 61.0, 79.0, 87.0, 81.0, 137.0, 58.0], "unit": "score", "name": "audio-fft", "value": 86.3}, {"lowerIsBetter": true, "replicates": [83.0, 89.0, 126.0, 78.0, 80.0, 82.0, 118.0, 79.0, 80.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 93.2}, {"lowerIsBetter": true, "replicates": [94.0, 76.0, 135.0, 127.0, 92.0, 89.0, 92.0, 89.0, 92.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.5}, {"lowerIsBetter": true, "replicates": [148.0, 151.0, 97.0, 97.0, 97.0, 143.0, 138.0, 97.0, 104.0, 98.0], "unit": "score", "name": "imaging-darkroom", "value": 117.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 93.0, 130.0, 142.0, 109.0, 149.0, 144.0, 102.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 115.0}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 57.0, 54.0, 56.0, 56.0, 57.0, 58.0, 79.0, 86.0], "unit": "score", "name": "json-parse-financial", "value": 61.4}, {"lowerIsBetter": true, "replicates": [62.0, 66.0, 72.0, 66.0, 72.0, 73.0, 70.0, 68.0, 65.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 85.0, 85.0, 84.0, 89.0, 84.0, 84.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [134.0, 137.0, 133.0, 114.0, 134.0, 130.0, 136.0, 135.0, 128.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.5}, {"lowerIsBetter": true, "replicates": [130.0, 142.0, 139.0, 143.0, 144.0, 137.0, 138.0, 180.0, 189.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [71.0, 88.0, 98.0, 91.0, 96.0, 90.0, 75.0, 67.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 81.2}], "name": "kraken", "value": 1582.7}]} 21:43:21 INFO - Return code: 0 21:43:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:43:21 ERROR - # TBPL SUCCESS # 21:43:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:43:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:43:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:43:21 INFO - 2016-03-11 21:43:21.599 screenresolution[1691:12220] starting screenresolution argv=screenresolution get 21:43:21 INFO - 2016-03-11 21:43:21.602 screenresolution[1691:12220] Display 0: 1600x1200x32@60 21:43:21 INFO - 2016-03-11 21:43:21.608 screenresolution[1692:12223] starting screenresolution argv=screenresolution list 21:43:21 INFO - Available Modes on Display 0 21:43:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:43:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:43:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:43:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:43:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:43:21 INFO - Intel Iris: 21:43:21 INFO - Chipset Model: Intel Iris 21:43:21 INFO - Type: GPU 21:43:21 INFO - Bus: Built-In 21:43:21 INFO - VRAM (Dynamic, Max): 1536 MB 21:43:21 INFO - Vendor: Intel (0x8086) 21:43:21 INFO - Device ID: 0x0a2e 21:43:21 INFO - Revision ID: 0x0009 21:43:21 INFO - Displays: 21:43:21 INFO - Display: 21:43:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:43:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:43:21 INFO - Display Serial Number: 1600x1200 60 21:43:21 INFO - Main Display: Yes 21:43:21 INFO - Mirror: Off 21:43:21 INFO - Online: Yes 21:43:21 INFO - Rotation: Supported 21:43:21 INFO - Return code: 0 21:43:21 INFO - Running post-action listener: _resource_record_post_action 21:43:21 INFO - Running post-run listener: _resource_record_post_run 21:43:22 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 34237952; Write bytes: 709037568; Read time: 365; Write time: 1876 21:43:22 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395485696; Write bytes: 389370880; Read time: 29864; Write time: 699 21:43:22 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 32439808; Write bytes: 304470528; Read time: 345; Write time: 1140 21:43:22 INFO - Running post-run listener: _upload_blobber_files 21:43:22 INFO - Blob upload gear active. 21:43:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:43:22 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 21:43:22 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'] 21:43:22 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 21:43:23 INFO - (blobuploader) - INFO - Open directory for files ... 21:43:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:43:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:43:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:24 INFO - (blobuploader) - INFO - Done attempting. 21:43:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:43:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:43:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:25 INFO - (blobuploader) - INFO - Done attempting. 21:43:25 INFO - (blobuploader) - INFO - Iteration through files over. 21:43:25 INFO - Return code: 0 21:43:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:43:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:43:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38ec9f9b65606bc264c55ee4b5c15178c79ca96a48ac000675b3499f56b2e1f9ac99c44a50f105c99f8af4ac77ea763331b6723e4b84ea9165146a388cc51b3e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3838a1d278105c8ca45ff183772dce2360640e35fa2a162a3379329d90c8f72db905d756abdb6a7cb369f8a3e71186871e4be4a397b277901c04bada15635b0"} 21:43:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:43:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:43:25 INFO - Contents: 21:43:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38ec9f9b65606bc264c55ee4b5c15178c79ca96a48ac000675b3499f56b2e1f9ac99c44a50f105c99f8af4ac77ea763331b6723e4b84ea9165146a388cc51b3e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3838a1d278105c8ca45ff183772dce2360640e35fa2a162a3379329d90c8f72db905d756abdb6a7cb369f8a3e71186871e4be4a397b277901c04bada15635b0"} 21:43:25 INFO - Running post-run listener: copy_logs_to_upload_dir 21:43:25 INFO - Copying logs to upload dir... 21:43:25 INFO - mkdir: /builds/slave/test/build/upload/logs 21:43:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.927477 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-03-11 21:43:25.268414) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 21:43:25.273033) ========= 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.4mwFOAlehC/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.JTx797G1cV/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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/38ec9f9b65606bc264c55ee4b5c15178c79ca96a48ac000675b3499f56b2e1f9ac99c44a50f105c99f8af4ac77ea763331b6723e4b84ea9165146a388cc51b3e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3838a1d278105c8ca45ff183772dce2360640e35fa2a162a3379329d90c8f72db905d756abdb6a7cb369f8a3e71186871e4be4a397b277901c04bada15635b0"} build_url:https://queue.taskcluster.net/v1/task/BrSqm126T_mCHxQfVT6riQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/BrSqm126T_mCHxQfVT6riQ/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/38ec9f9b65606bc264c55ee4b5c15178c79ca96a48ac000675b3499f56b2e1f9ac99c44a50f105c99f8af4ac77ea763331b6723e4b84ea9165146a388cc51b3e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3838a1d278105c8ca45ff183772dce2360640e35fa2a162a3379329d90c8f72db905d756abdb6a7cb369f8a3e71186871e4be4a397b277901c04bada15635b0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 21:43:25.300426) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 21:43:25.303731) ========= 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.4mwFOAlehC/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.JTx797G1cV/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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.005207 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 21:43:25.352364) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 21:43:25.355677) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 21:43:25.356051) ========= ========= Total master_lag: 1.60 =========