builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0169 starttime: 1458821145.72 results: success (0) buildid: 20160324031044 builduid: 6de99a595a5c4c43b21cdaa6dac173b1 revision: faa774eaf02c4128d0a80ad4d465c368c0cf023f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 05:05:45.721171) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 05:05:45.724633) ========= ========= Started set props: basedir (results: 0, elapsed: 3 secs) (at 2016-03-24 05:05:45.724943) ========= 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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.005472 basedir: '/builds/slave/test' ========= master_lag: 3.48 ========= ========= Finished set props: basedir (results: 0, elapsed: 3 secs) (at 2016-03-24 05:05:49.215266) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 4 secs) (at 2016-03-24 05:05:49.215585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 4 secs) (at 2016-03-24 05:05:53.525039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:05:53.525310) ========= 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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.005461 ========= master_lag: 0.58 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:05:54.110637) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 05:05:54.110909) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 05:05:54.111236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-24 05:05:54.111500) ========= 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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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-24 05:05:54-- 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% 175M=0s 2016-03-24 05:05:54 (175 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.547315 ========= master_lag: 2.98 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-24 05:05:57.639047) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:05:57.639324) ========= 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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.036417 ========= master_lag: 0.54 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:05:58.219910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-03-24 05:05:58.220265) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev faa774eaf02c4128d0a80ad4d465c368c0cf023f --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 faa774eaf02c4128d0a80ad4d465c368c0cf023f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xiBSwLlaRu/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.YTUmXbmSzt/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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-24 05:05:58,311 truncating revision to first 12 chars 2016-03-24 05:05:58,311 Setting DEBUG logging. 2016-03-24 05:05:58,311 attempt 1/10 2016-03-24 05:05:58,312 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/faa774eaf02c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 05:05:58,948 unpacking tar archive at: fx-team-faa774eaf02c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.880778 ========= master_lag: 3.80 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-03-24 05:06:02.905989) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 05:06:02.906297) ========= echo faa774eaf02c4128d0a80ad4d465c368c0cf023f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'faa774eaf02c4128d0a80ad4d465c368c0cf023f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xiBSwLlaRu/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.YTUmXbmSzt/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 faa774eaf02c4128d0a80ad4d465c368c0cf023f program finished with exit code 0 elapsedTime=0.005392 script_repo_revision: 'faa774eaf02c4128d0a80ad4d465c368c0cf023f' ========= master_lag: 0.22 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 05:06:03.131214) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 05:06:03.131494) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 05:06:03.195932) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-24 05:06:03.196187) ========= /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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 05:06:03 INFO - MultiFileLogger online at 20160324 05:06:03 in /builds/slave/test 05:06:03 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 05:06:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:06:03 INFO - {'append_to_log': False, 05:06:03 INFO - 'base_work_dir': '/builds/slave/test', 05:06:03 INFO - 'blob_upload_branch': 'Fx-Team', 05:06:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:06:03 INFO - 'branch': 'Fx-Team', 05:06:03 INFO - 'buildbot_json_path': 'buildprops.json', 05:06:03 INFO - 'config_files': ('talos/mac_config.py',), 05:06:03 INFO - 'default_actions': ('clobber', 05:06:03 INFO - 'read-buildbot-config', 05:06:03 INFO - 'download-and-extract', 05:06:03 INFO - 'populate-webroot', 05:06:03 INFO - 'create-virtualenv', 05:06:03 INFO - 'install', 05:06:03 INFO - 'run-tests'), 05:06:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:06:03 INFO - 'download_minidump_stackwalk': True, 05:06:03 INFO - 'download_symbols': 'ondemand', 05:06:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:06:03 INFO - 'tooltool.py': '/tools/tooltool.py', 05:06:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:06:03 INFO - '/tools/misc-python/virtualenv.py')}, 05:06:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:06:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:06:03 INFO - 'installer_path': 'installer.exe', 05:06:03 INFO - 'log_level': 'info', 05:06:03 INFO - 'log_name': 'talos', 05:06:03 INFO - 'log_to_console': True, 05:06:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:06:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:06:03 INFO - 'opt_config_files': (), 05:06:03 INFO - 'pip_index': False, 05:06:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:06:03 INFO - 'cmd': ('bash', 05:06:03 INFO - '-c', 05:06:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:06:03 INFO - 'enabled': True, 05:06:03 INFO - 'halt_on_failure': False, 05:06:03 INFO - 'name': 'check_screen_resolution'},), 05:06:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:06:03 INFO - 'cmd': ('bash', 05:06:03 INFO - '-c', 05:06:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:06:03 INFO - 'enabled': True, 05:06:03 INFO - 'halt_on_failure': False, 05:06:03 INFO - 'name': 'check_screen_resolution'},), 05:06:03 INFO - 'run_cmd_checks_enabled': True, 05:06:03 INFO - 'sps_profile': False, 05:06:03 INFO - 'sps_profile_interval': 0, 05:06:03 INFO - 'suite': 'dromaeojs-e10s', 05:06:03 INFO - 'system_bits': '32', 05:06:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:06:03 INFO - 'title': 't-yosemite-r7-0169', 05:06:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:06:03 INFO - 'use_talos_json': True, 05:06:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:06:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:06:03 INFO - 'work_dir': 'build'} 05:06:03 INFO - ##### 05:06:03 INFO - ##### Running clobber step. 05:06:03 INFO - ##### 05:06:03 INFO - Running pre-action listener: _resource_record_pre_action 05:06:03 INFO - Running main action method: clobber 05:06:03 INFO - rmtree: /builds/slave/test/build 05:06:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:06:05 INFO - Running post-action listener: _resource_record_post_action 05:06:05 INFO - ##### 05:06:05 INFO - ##### Running read-buildbot-config step. 05:06:05 INFO - ##### 05:06:05 INFO - Running pre-action listener: _resource_record_pre_action 05:06:05 INFO - Running main action method: read_buildbot_config 05:06:05 INFO - Using buildbot properties: 05:06:05 INFO - { 05:06:05 INFO - "project": "", 05:06:05 INFO - "product": "firefox", 05:06:05 INFO - "script_repo_revision": "production", 05:06:05 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:06:05 INFO - "repository": "", 05:06:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:06:05 INFO - "buildid": "20160324031044", 05:06:05 INFO - "pgo_build": "False", 05:06:05 INFO - "basedir": "/builds/slave/test", 05:06:05 INFO - "buildnumber": 562, 05:06:05 INFO - "slavename": "t-yosemite-r7-0169", 05:06:05 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:06:05 INFO - "platform": "yosemite_r7", 05:06:05 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:06:05 INFO - "branch": "fx-team", 05:06:05 INFO - "repo_path": "integration/fx-team", 05:06:05 INFO - "revision": "faa774eaf02c4128d0a80ad4d465c368c0cf023f", 05:06:05 INFO - "stage_platform": "macosx64", 05:06:05 INFO - "builduid": "6de99a595a5c4c43b21cdaa6dac173b1", 05:06:05 INFO - "slavebuilddir": "test" 05:06:05 INFO - } 05:06:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:06:05 INFO - Running post-action listener: _resource_record_post_action 05:06:05 INFO - ##### 05:06:05 INFO - ##### Running download-and-extract step. 05:06:05 INFO - ##### 05:06:05 INFO - Running pre-action listener: _resource_record_pre_action 05:06:05 INFO - Running main action method: download_and_extract 05:06:05 INFO - mkdir: /builds/slave/test/build/tests 05:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:05 INFO - https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:06:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:06:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:06:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 05:06:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 05:06:06 INFO - Downloaded 1199 bytes. 05:06:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:06:06 INFO - Using the following test package requirements: 05:06:06 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:06:06 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:06:06 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:06:06 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:06:06 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:06:06 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:06:06 INFO - u'jsshell-mac.zip'], 05:06:06 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:06:06 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:06:06 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:06:06 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:06:06 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:06:06 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:06:06 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:06:06 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:06:06 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:06:06 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:06:06 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:06:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:06: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')]} 05:06:06 INFO - https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:06:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:06:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:06:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 05:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 05:06:07 INFO - Downloaded 17921966 bytes. 05:06:07 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'] 05:06:07 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 05:06:10 INFO - Return code: 0 05:06:10 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 05:06: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')]} 05:06:10 INFO - https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:06:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:06:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:06:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 05:06:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 05:06:12 INFO - Downloaded 17921966 bytes. 05:06:12 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'] 05:06:12 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 05:06:15 INFO - Return code: 0 05:06:15 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')]} 05:06:15 INFO - https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:06:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:06:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:06:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 05:06:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 05:06:16 INFO - Downloaded 10847187 bytes. 05:06:16 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'] 05:06:16 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 05:06:16 INFO - Return code: 0 05:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:16 INFO - https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:06:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:06:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:06:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 05:06:20 INFO - Downloaded 111285803 bytes. 05:06:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:06:20 INFO - mkdir: /builds/slave/test/properties 05:06:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:06:20 INFO - Writing to file /builds/slave/test/properties/build_url 05:06:20 INFO - Contents: 05:06:20 INFO - build_url:https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:06:21 INFO - Running post-action listener: _resource_record_post_action 05:06:21 INFO - Running post-action listener: set_extra_try_arguments 05:06:21 INFO - ##### 05:06:21 INFO - ##### Running populate-webroot step. 05:06:21 INFO - ##### 05:06:21 INFO - Running pre-action listener: _resource_record_pre_action 05:06:21 INFO - Running main action method: populate_webroot 05:06:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:06:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:06:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:06:21 INFO - '--tppagecycles', 05:06:21 INFO - '7'], 05:06:21 INFO - 'tests': ['tsvgm']}}, 05:06:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:06:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:06:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:06:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:06:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:06:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:06:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:21 INFO - 'talos_options': ['--e10s'], 05:06:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:21 INFO - 'tests': ['damp', 'tps']}, 05:06:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:21 INFO - 'talos_options': ['--e10s'], 05:06:21 INFO - 'tests': ['damp', 'tps']}, 05:06:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:06:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:06:21 INFO - 'other': {'tests': ['a11yr', 05:06:21 INFO - 'ts_paint', 05:06:21 INFO - 'tpaint', 05:06:21 INFO - 'sessionrestore', 05:06:21 INFO - 'sessionrestore_no_auto_restore', 05:06:21 INFO - 'tabpaint']}, 05:06:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:06:21 INFO - 'tests': ['a11yr', 05:06:21 INFO - 'ts_paint', 05:06:21 INFO - 'tpaint', 05:06:21 INFO - 'sessionrestore', 05:06:21 INFO - 'sessionrestore_no_auto_restore', 05:06:21 INFO - 'tabpaint']}, 05:06:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:06:21 INFO - 'tests': ['a11yr', 05:06:21 INFO - 'ts_paint', 05:06:21 INFO - 'tpaint', 05:06:21 INFO - 'sessionrestore', 05:06:21 INFO - 'sessionrestore_no_auto_restore', 05:06:21 INFO - 'tabpaint']}, 05:06:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:06:21 INFO - 'tests': ['a11yr', 05:06:21 INFO - 'ts_paint', 05:06:21 INFO - 'tpaint', 05:06:21 INFO - 'sessionrestore', 05:06:21 INFO - 'sessionrestore_no_auto_restore', 05:06:21 INFO - 'tabpaint']}, 05:06:21 INFO - 'other_l64': {'tests': ['a11yr', 05:06:21 INFO - 'ts_paint', 05:06:21 INFO - 'tpaint', 05:06:21 INFO - 'sessionrestore', 05:06:21 INFO - 'sessionrestore_no_auto_restore', 05:06:21 INFO - 'tabpaint']}, 05:06:21 INFO - 'other_nol64': {'tests': ['a11yr', 05:06:21 INFO - 'ts_paint', 05:06:21 INFO - 'tpaint', 05:06:21 INFO - 'sessionrestore', 05:06:21 INFO - 'sessionrestore_no_auto_restore', 05:06:21 INFO - 'tabpaint']}, 05:06:21 INFO - 'svgr': {'tests': ['tsvgx', 05:06:21 INFO - 'tsvgr_opacity', 05:06:21 INFO - 'tart', 05:06:21 INFO - 'tscrollx', 05:06:21 INFO - 'cart']}, 05:06:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:06:21 INFO - 'tests': ['tsvgx', 05:06:21 INFO - 'tsvgr_opacity', 05:06:21 INFO - 'tart', 05:06:21 INFO - 'tscrollx', 05:06:21 INFO - 'cart']}, 05:06:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:21 INFO - 'tests': ['tp5o']}, 05:06:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:21 INFO - 'talos_options': ['--e10s'], 05:06:21 INFO - 'tests': ['tp5o']}, 05:06:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:21 INFO - 'talos_options': ['--xperf_path', 05:06:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:21 INFO - 'tests': ['tp5n']}, 05:06:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:21 INFO - 'talos_options': ['--e10s', 05:06:21 INFO - '--xperf_path', 05:06:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:21 INFO - 'tests': ['tp5n']}}, 05:06:21 INFO - 'talos.zip': {'path': '', 05:06:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:06:21 INFO - Running post-action listener: _resource_record_post_action 05:06:21 INFO - ##### 05:06:21 INFO - ##### Running create-virtualenv step. 05:06:21 INFO - ##### 05:06:21 INFO - Running pre-action listener: _resource_record_pre_action 05:06:21 INFO - Running main action method: create_virtualenv 05:06:21 INFO - Creating virtualenv /builds/slave/test/build/venv 05:06:21 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 05:06:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:06:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:06:21 INFO - Using real prefix '/tools/python27' 05:06:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:06:22 INFO - Installing distribute.............................................................................................................................................................................................done. 05:06:25 INFO - Installing pip.................done. 05:06:25 INFO - Return code: 0 05:06:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:06:25 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')]} 05:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:25 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')]} 05:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:25 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 0x101910a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101920420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd25adc5650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017afe00>, '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 0x101618db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aab20>, '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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 05:06:25 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 05:06:25 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 05:06:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xiBSwLlaRu/Render', 05:06:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:25 INFO - 'HOME': '/Users/cltbld', 05:06:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:25 INFO - 'LOGNAME': 'cltbld', 05:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:25 INFO - 'MOZ_NO_REMOTE': '1', 05:06:25 INFO - 'NO_EM_RESTART': '1', 05:06:25 INFO - 'PAGER': '/bin/cat', 05:06:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:25 INFO - 'PWD': '/builds/slave/test', 05:06:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:25 INFO - 'SHELL': '/bin/bash', 05:06:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YTUmXbmSzt/Listeners', 05:06:25 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 05:06:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:25 INFO - 'USER': 'cltbld', 05:06:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:25 INFO - 'XPC_FLAGS': '0x0', 05:06:25 INFO - 'XPC_SERVICE_NAME': '0', 05:06:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:25 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 05:06:25 INFO - Cleaning up... 05:06:25 INFO - Return code: 0 05:06:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:06:25 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')]} 05:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:25 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')]} 05:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:25 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 0x101910a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101920420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd25adc5650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017afe00>, '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 0x101618db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aab20>, '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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 05:06:25 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 05:06:25 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 05:06:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xiBSwLlaRu/Render', 05:06:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:25 INFO - 'HOME': '/Users/cltbld', 05:06:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:25 INFO - 'LOGNAME': 'cltbld', 05:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:25 INFO - 'MOZ_NO_REMOTE': '1', 05:06:25 INFO - 'NO_EM_RESTART': '1', 05:06:25 INFO - 'PAGER': '/bin/cat', 05:06:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:25 INFO - 'PWD': '/builds/slave/test', 05:06:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:25 INFO - 'SHELL': '/bin/bash', 05:06:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YTUmXbmSzt/Listeners', 05:06:25 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 05:06:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:25 INFO - 'USER': 'cltbld', 05:06:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:25 INFO - 'XPC_FLAGS': '0x0', 05:06:25 INFO - 'XPC_SERVICE_NAME': '0', 05:06:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:25 INFO - Downloading/unpacking psutil>=0.7.1 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 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 05:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:06:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:28 INFO - Installing collected packages: psutil 05:06:28 INFO - Running setup.py install for psutil 05:06:28 INFO - building 'psutil._psutil_osx' extension 05:06:28 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 05:06:29 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 05:06:29 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 05:06:29 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 05:06:29 INFO - building 'psutil._psutil_posix' extension 05:06:29 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 05:06:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:06:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:06:29 INFO - ^ 05:06:29 INFO - 1 warning generated. 05:06:29 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 05:06:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:29 INFO - Successfully installed psutil 05:06:29 INFO - Cleaning up... 05:06:29 INFO - Return code: 0 05:06:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:29 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 0x101910a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101920420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd25adc5650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017afe00>, '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 0x101618db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aab20>, '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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 05:06:29 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 05:06:29 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 05:06:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xiBSwLlaRu/Render', 05:06:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:29 INFO - 'HOME': '/Users/cltbld', 05:06:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:29 INFO - 'LOGNAME': 'cltbld', 05:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:29 INFO - 'MOZ_NO_REMOTE': '1', 05:06:29 INFO - 'NO_EM_RESTART': '1', 05:06:29 INFO - 'PAGER': '/bin/cat', 05:06:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:29 INFO - 'PWD': '/builds/slave/test', 05:06:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:29 INFO - 'SHELL': '/bin/bash', 05:06:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YTUmXbmSzt/Listeners', 05:06:29 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 05:06:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:29 INFO - 'USER': 'cltbld', 05:06:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:29 INFO - 'XPC_FLAGS': '0x0', 05:06:29 INFO - 'XPC_SERVICE_NAME': '0', 05:06:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:06:30 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 05:06:30 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 05:06:30 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 05:06:30 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 05:06:30 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 05:06:30 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 05:06:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:06:32 INFO - Installing collected packages: mozsystemmonitor 05:06:32 INFO - Running setup.py install for mozsystemmonitor 05:06:32 INFO - Successfully installed mozsystemmonitor 05:06:32 INFO - Cleaning up... 05:06:32 INFO - Return code: 0 05:06:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06:32 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')]} 05:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:32 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')]} 05:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:32 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 0x101910a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101920420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd25adc5650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017afe00>, '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 0x101618db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aab20>, '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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 05:06:32 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 05:06:32 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 05:06:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xiBSwLlaRu/Render', 05:06:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:32 INFO - 'HOME': '/Users/cltbld', 05:06:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:32 INFO - 'LOGNAME': 'cltbld', 05:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:32 INFO - 'MOZ_NO_REMOTE': '1', 05:06:32 INFO - 'NO_EM_RESTART': '1', 05:06:32 INFO - 'PAGER': '/bin/cat', 05:06:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:32 INFO - 'PWD': '/builds/slave/test', 05:06:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:32 INFO - 'SHELL': '/bin/bash', 05:06:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YTUmXbmSzt/Listeners', 05:06:32 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 05:06:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:32 INFO - 'USER': 'cltbld', 05:06:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:32 INFO - 'XPC_FLAGS': '0x0', 05:06:32 INFO - 'XPC_SERVICE_NAME': '0', 05:06:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:33 INFO - Downloading/unpacking blobuploader==1.2.4 05:06:33 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 05:06:33 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 05:06:33 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 05:06:33 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 05:06:33 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 05:06:33 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 05:06:35 INFO - Downloading blobuploader-1.2.4.tar.gz 05:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:06:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:06:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:06:36 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 05:06:36 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 05:06:36 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 05:06:36 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 05:06:36 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 05:06:36 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 05:06:36 INFO - Downloading docopt-0.6.1.tar.gz 05:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:06:36 INFO - Installing collected packages: blobuploader, requests, docopt 05:06:36 INFO - Running setup.py install for blobuploader 05:06:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:06:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:06:37 INFO - Running setup.py install for requests 05:06:37 INFO - Running setup.py install for docopt 05:06:37 INFO - Successfully installed blobuploader requests docopt 05:06:37 INFO - Cleaning up... 05:06:37 INFO - Return code: 0 05:06:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:37 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 0x101910a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101920420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd25adc5650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017afe00>, '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 0x101618db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aab20>, '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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 05:06:37 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 05:06:37 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 05:06:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xiBSwLlaRu/Render', 05:06:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:37 INFO - 'HOME': '/Users/cltbld', 05:06:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:37 INFO - 'LOGNAME': 'cltbld', 05:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:37 INFO - 'MOZ_NO_REMOTE': '1', 05:06:37 INFO - 'NO_EM_RESTART': '1', 05:06:37 INFO - 'PAGER': '/bin/cat', 05:06:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:37 INFO - 'PWD': '/builds/slave/test', 05:06:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:37 INFO - 'SHELL': '/bin/bash', 05:06:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YTUmXbmSzt/Listeners', 05:06:37 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 05:06:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:37 INFO - 'USER': 'cltbld', 05:06:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:37 INFO - 'XPC_FLAGS': '0x0', 05:06:37 INFO - 'XPC_SERVICE_NAME': '0', 05:06:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-F28Tmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-tcVRof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-miTlvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-P4vXuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-2b0IbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-oYC6X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-uHh_ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-HwaLPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-OT3fST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-xi6cXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:39 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-h5ZLdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:39 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-NZ2nck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:39 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-nklISx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:39 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-1a6r9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:39 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-b0pHxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:39 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-PJOR8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:39 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-JprsRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:06:39 INFO - Running setup.py install for manifestparser 05:06:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:06:39 INFO - Running setup.py install for mozcrash 05:06:40 INFO - Running setup.py install for mozdebug 05:06:40 INFO - Running setup.py install for mozdevice 05:06:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Running setup.py install for mozfile 05:06:40 INFO - Running setup.py install for mozhttpd 05:06:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Running setup.py install for mozinfo 05:06:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Running setup.py install for mozInstall 05:06:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Running setup.py install for mozleak 05:06:41 INFO - Running setup.py install for mozlog 05:06:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:06:41 INFO - Running setup.py install for moznetwork 05:06:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:06:41 INFO - Running setup.py install for mozprocess 05:06:41 INFO - Running setup.py install for mozprofile 05:06:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:06:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:06:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:06:41 INFO - Running setup.py install for mozrunner 05:06:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:06:41 INFO - Running setup.py install for mozscreenshot 05:06:42 INFO - Running setup.py install for moztest 05:06:42 INFO - Running setup.py install for mozversion 05:06:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:06:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:06:42 INFO - Cleaning up... 05:06:42 INFO - Return code: 0 05:06:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:42 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')]} 05:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:42 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')]} 05:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:42 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 0x101910a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101920420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd25adc5650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017afe00>, '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 0x101618db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aab20>, '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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 05:06:42 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 05:06:42 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 05:06:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xiBSwLlaRu/Render', 05:06:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:42 INFO - 'HOME': '/Users/cltbld', 05:06:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:42 INFO - 'LOGNAME': 'cltbld', 05:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:42 INFO - 'MOZ_NO_REMOTE': '1', 05:06:42 INFO - 'NO_EM_RESTART': '1', 05:06:42 INFO - 'PAGER': '/bin/cat', 05:06:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:42 INFO - 'PWD': '/builds/slave/test', 05:06:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:42 INFO - 'SHELL': '/bin/bash', 05:06:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YTUmXbmSzt/Listeners', 05:06:42 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 05:06:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:42 INFO - 'USER': 'cltbld', 05:06:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:42 INFO - 'XPC_FLAGS': '0x0', 05:06:42 INFO - 'XPC_SERVICE_NAME': '0', 05:06:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:42 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-Uo5oqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:42 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)) 05:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:42 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-KVpPn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:42 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)) 05:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:42 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-fKOJeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:42 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)) 05:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:42 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-nlrDw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:43 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)) 05:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:43 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-8cDyXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:43 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)) 05:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:43 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-a9_AYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:43 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)) 05:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:43 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-LCZCku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:43 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)) 05:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:43 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-5PswE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:43 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)) 05:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:43 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-HjsWdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:43 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)) 05:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:43 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-4LdA4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:43 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)) 05:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:43 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-K3sCRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:43 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)) 05:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:43 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-no3J_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:43 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)) 05:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:43 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-PzCX2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:43 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)) 05:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:44 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-VXYEYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:44 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)) 05:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:44 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-0c4fE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:44 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)) 05:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:44 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-bi46zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:44 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)) 05:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:44 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-CGUP5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:44 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)) 05:06:44 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)) 05:06:44 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)) 05:06:44 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)) 05:06:44 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)) 05:06:44 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)) 05:06:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:46 INFO - Downloading blessings-1.6.tar.gz 05:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:06:47 INFO - Installing collected packages: blessings 05:06:47 INFO - Running setup.py install for blessings 05:06:47 INFO - Successfully installed blessings 05:06:47 INFO - Cleaning up... 05:06:47 INFO - Return code: 0 05:06:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:06:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:47 INFO - Reading from file tmpfile_stdout 05:06:47 INFO - Current package versions: 05:06:47 INFO - blessings == 1.6 05:06:47 INFO - blobuploader == 1.2.4 05:06:47 INFO - docopt == 0.6.1 05:06:47 INFO - manifestparser == 1.1 05:06:47 INFO - mozInstall == 1.12 05:06:47 INFO - mozcrash == 0.17 05:06:47 INFO - mozdebug == 0.1 05:06:47 INFO - mozdevice == 0.48 05:06:47 INFO - mozfile == 1.2 05:06:47 INFO - mozhttpd == 0.7 05:06:47 INFO - mozinfo == 0.9 05:06:47 INFO - mozleak == 0.1 05:06:47 INFO - mozlog == 3.1 05:06:47 INFO - moznetwork == 0.27 05:06:47 INFO - mozprocess == 0.22 05:06:47 INFO - mozprofile == 0.28 05:06:47 INFO - mozrunner == 6.11 05:06:47 INFO - mozscreenshot == 0.1 05:06:47 INFO - mozsystemmonitor == 0.0 05:06:47 INFO - moztest == 0.7 05:06:47 INFO - mozversion == 1.4 05:06:47 INFO - psutil == 3.1.1 05:06:47 INFO - requests == 1.2.3 05:06:47 INFO - wsgiref == 0.1.2 05:06:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:47 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 0x101910a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101920420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd25adc5650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017afe00>, '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 0x101618db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aab20>, '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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 05:06:47 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 05:06:47 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 05:06:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xiBSwLlaRu/Render', 05:06:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:47 INFO - 'HOME': '/Users/cltbld', 05:06:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:47 INFO - 'LOGNAME': 'cltbld', 05:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:47 INFO - 'MOZ_NO_REMOTE': '1', 05:06:47 INFO - 'NO_EM_RESTART': '1', 05:06:47 INFO - 'PAGER': '/bin/cat', 05:06:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:47 INFO - 'PWD': '/builds/slave/test', 05:06:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:47 INFO - 'SHELL': '/bin/bash', 05:06:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YTUmXbmSzt/Listeners', 05:06:47 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 05:06:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:47 INFO - 'USER': 'cltbld', 05:06:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:47 INFO - 'XPC_FLAGS': '0x0', 05:06:47 INFO - 'XPC_SERVICE_NAME': '0', 05:06:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:47 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)) 05:06:47 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)) 05:06:47 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)) 05:06:47 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)) 05:06:47 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)) 05:06:47 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)) 05:06:47 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)) 05:06:47 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)) 05:06:47 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)) 05:06:47 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)) 05:06:47 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)) 05:06:47 INFO - Cleaning up... 05:06:47 INFO - Return code: 0 05:06:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101910a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101920420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd25adc5650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017afe00>, '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 0x101618db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aab20>, '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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 05:06:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:06:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xiBSwLlaRu/Render', 05:06:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:47 INFO - 'HOME': '/Users/cltbld', 05:06:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:47 INFO - 'LOGNAME': 'cltbld', 05:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:47 INFO - 'MOZ_NO_REMOTE': '1', 05:06:47 INFO - 'NO_EM_RESTART': '1', 05:06:47 INFO - 'PAGER': '/bin/cat', 05:06:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:47 INFO - 'PWD': '/builds/slave/test', 05:06:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:47 INFO - 'SHELL': '/bin/bash', 05:06:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YTUmXbmSzt/Listeners', 05:06:47 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 05:06:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:47 INFO - 'USER': 'cltbld', 05:06:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:47 INFO - 'XPC_FLAGS': '0x0', 05:06:47 INFO - 'XPC_SERVICE_NAME': '0', 05:06:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:48 INFO - Downloading/unpacking jsonschema 05:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:06:50 INFO - Downloading/unpacking functools32 (from jsonschema) 05:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:51 INFO - Downloading functools32-3.2.3-2.tar.gz 05:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:06:51 INFO - warning: no files found matching '*.txt' 05:06:51 INFO - no previously-included directories found matching 'build' 05:06:51 INFO - no previously-included directories found matching 'dist' 05:06:51 INFO - no previously-included directories found matching '.git*' 05:06:51 INFO - Installing collected packages: jsonschema, functools32 05:06:51 INFO - Running setup.py install for functools32 05:06:51 INFO - warning: no files found matching '*.txt' 05:06:51 INFO - no previously-included directories found matching 'build' 05:06:51 INFO - no previously-included directories found matching 'dist' 05:06:51 INFO - no previously-included directories found matching '.git*' 05:06:51 INFO - Successfully installed jsonschema functools32 05:06:51 INFO - Cleaning up... 05:06:51 INFO - Return code: 0 05:06:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101910a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101920420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd25adc5650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017afe00>, '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 0x101618db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aab20>, '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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 05:06: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', 'flake8'] in /builds/slave/test/build 05:06: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 flake8 05:06:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xiBSwLlaRu/Render', 05:06:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:51 INFO - 'HOME': '/Users/cltbld', 05:06:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:51 INFO - 'LOGNAME': 'cltbld', 05:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:51 INFO - 'MOZ_NO_REMOTE': '1', 05:06:51 INFO - 'NO_EM_RESTART': '1', 05:06:51 INFO - 'PAGER': '/bin/cat', 05:06:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:51 INFO - 'PWD': '/builds/slave/test', 05:06:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:51 INFO - 'SHELL': '/bin/bash', 05:06:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YTUmXbmSzt/Listeners', 05:06:51 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 05:06:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:51 INFO - 'USER': 'cltbld', 05:06:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:51 INFO - 'XPC_FLAGS': '0x0', 05:06:51 INFO - 'XPC_SERVICE_NAME': '0', 05:06:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:51 INFO - Downloading/unpacking flake8 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:06:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:06:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:06:56 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 05:06:56 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 05:06:56 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 05:06:56 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 05:06:56 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 05:06:56 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 05:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:06:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:06:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:06:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:06:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:06:56 INFO - no previously-included directories found matching 'docs/_build' 05:06:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:06:57 INFO - Running setup.py install for pep8 05:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:06:57 INFO - no previously-included directories found matching 'docs/_build' 05:06:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:06:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:06:57 INFO - Cleaning up... 05:06:57 INFO - Return code: 0 05:06:57 INFO - Running post-action listener: _resource_record_post_action 05:06:57 INFO - Running post-action listener: _start_resource_monitoring 05:06:57 INFO - Starting resource monitoring. 05:06:57 INFO - ##### 05:06:57 INFO - ##### Running install step. 05:06:57 INFO - ##### 05:06:57 INFO - Running pre-action listener: _resource_record_pre_action 05:06:57 INFO - Running main action method: install 05:06:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:57 INFO - Reading from file tmpfile_stdout 05:06:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:06:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:06:57 INFO - Reading from file tmpfile_stdout 05:06:57 INFO - Output received: 05:06:57 INFO - Usage: mozinstall [options] installer 05:06:57 INFO - Options: 05:06:57 INFO - -h, --help show this help message and exit 05:06:57 INFO - -d DEST, --destination=DEST 05:06:57 INFO - Directory to install application into. [default: 05:06:57 INFO - "/builds/slave/test"] 05:06:57 INFO - --app=APP Application being installed. [default: firefox] 05:06:57 INFO - mkdir: /builds/slave/test/build/application 05:06:57 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'] 05:06:57 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 05:07:32 INFO - Reading from file tmpfile_stdout 05:07:32 INFO - Output received: 05:07:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:07:32 INFO - Running post-action listener: _resource_record_post_action 05:07:32 INFO - ##### 05:07:32 INFO - ##### Running run-tests step. 05:07:32 INFO - ##### 05:07:32 INFO - Running pre-action listener: _resource_record_pre_action 05:07:32 INFO - Running main action method: run_tests 05:07:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:07:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:07:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:07:32 INFO - 2016-03-24 05:07:32.255 screenresolution[1650:7977] starting screenresolution argv=screenresolution get 05:07:32 INFO - 2016-03-24 05:07:32.257 screenresolution[1650:7977] Display 0: 1600x1200x32@60 05:07:32 INFO - 2016-03-24 05:07:32.263 screenresolution[1651:7979] starting screenresolution argv=screenresolution list 05:07:32 INFO - Available Modes on Display 0 05:07:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:07:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:07:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:07:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:07:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:07:32 INFO - Intel Iris: 05:07:32 INFO - Chipset Model: Intel Iris 05:07:32 INFO - Type: GPU 05:07:32 INFO - Bus: Built-In 05:07:32 INFO - VRAM (Dynamic, Max): 1536 MB 05:07:32 INFO - Vendor: Intel (0x8086) 05:07:32 INFO - Device ID: 0x0a2e 05:07:32 INFO - Revision ID: 0x0009 05:07:32 INFO - Displays: 05:07:32 INFO - Display: 05:07:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:07:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:07:32 INFO - Display Serial Number: 1600x1200 60 05:07:32 INFO - Main Display: Yes 05:07:32 INFO - Mirror: Off 05:07:32 INFO - Online: Yes 05:07:32 INFO - Rotation: Supported 05:07:32 INFO - Return code: 0 05:07:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:07:32 INFO - Python 2.7.3 05:07:32 INFO - Return code: 0 05:07:32 INFO - grabbing minidump binary from tooltool 05:07:32 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')]} 05:07:32 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 0x1017afe00>, '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 0x101618db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:07:32 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 05:07:32 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 05:07:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:07:32 INFO - Return code: 0 05:07:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:07:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:07:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:07:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:07:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:07:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:07:33 INFO - Return code: 0 05:07:33 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/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--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 05:07:33 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/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0169 --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 05:07:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xiBSwLlaRu/Render', 05:07:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:33 INFO - 'HOME': '/Users/cltbld', 05:07:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:33 INFO - 'LOGNAME': 'cltbld', 05:07:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:07:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:33 INFO - 'MOZ_NO_REMOTE': '1', 05:07:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:07:33 INFO - 'NO_EM_RESTART': '1', 05:07:33 INFO - 'PAGER': '/bin/cat', 05:07:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:33 INFO - 'PWD': '/builds/slave/test', 05:07:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:07:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:33 INFO - 'SHELL': '/bin/bash', 05:07:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YTUmXbmSzt/Listeners', 05:07:33 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 05:07:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:33 INFO - 'USER': 'cltbld', 05:07:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:33 INFO - 'XPC_FLAGS': '0x0', 05:07:33 INFO - 'XPC_SERVICE_NAME': '0', 05:07:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:33 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/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--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 05:07:34 INFO - mozversion application_buildid: 20160324031044 05:07:34 INFO - mozversion application_changeset: faa774eaf02c4128d0a80ad4d465c368c0cf023f 05:07:34 INFO - mozversion application_display_name: Nightly 05:07:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:07:34 INFO - mozversion application_name: Firefox 05:07:34 INFO - mozversion application_remotingname: firefox 05:07:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:07:34 INFO - mozversion application_vendor: Mozilla 05:07:34 INFO - mozversion application_version: 48.0a1 05:07:34 INFO - mozversion platform_buildid: 20160324031044 05:07:34 INFO - mozversion platform_changeset: faa774eaf02c4128d0a80ad4d465c368c0cf023f 05:07:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:07:34 INFO - mozversion platform_version: 48.0a1 05:07:34 INFO - using testdate: 1458821254 05:07:34 INFO - actual date: 1458821254 05:07:34 INFO - starting webserver on 'localhost:49270' 05:07:34 INFO - SUITE-START | Running 2 tests 05:07:34 INFO - TEST-START | dromaeo_css 05:07:34 INFO - operating with platform_type : mac_ 05:07:34 INFO - Initialising browser for dromaeo_css test... 05:07:34 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpuq1jQc/profile http://localhost:49270/getInfo.html) 05:07:36 INFO - PROCESS | 1669 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:07:37 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 05:07:37 INFO - PROCESS | 1669 | colorDepth:24 05:07:37 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 05:07:37 INFO - PROCESS | 1669 | __metrics 05:07:37 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 05:07:37 INFO - TEST-INFO | 1669: exit 0 05:07:37 INFO - Browser initialized. 05:07:37 INFO - Running cycle 1/1 for dromaeo_css test... 05:07:37 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpuq1jQc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:49 INFO - PROCESS | 1674 | RSS: Main: 258039808 05:07:49 INFO - PROCESS | 1674 | 05:08:39 INFO - PROCESS | 1674 | 1458821319379 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] 05:10:49 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 05:10:51 INFO - PROCESS | 1674 | RSS: Main: 270585856 05:10:51 INFO - PROCESS | 1674 | 05:13:53 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 05:13:53 INFO - PROCESS | 1674 | RSS: Main: 281694208 05:13:53 INFO - PROCESS | 1674 | 05:16:55 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 05:16:56 INFO - PROCESS | 1674 | RSS: Main: 283877376 05:16:56 INFO - PROCESS | 1674 | 05:19:57 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 05:19:58 INFO - PROCESS | 1674 | RSS: Main: 284069888 05:19:58 INFO - PROCESS | 1674 | 05:23:01 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 05:23:01 INFO - PROCESS | 1674 | RSS: Main: 288993280 05:23:01 INFO - PROCESS | 1674 | 05:26:03 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 05:26:04 INFO - PROCESS | 1674 | RSS: Main: 289869824 05:26:04 INFO - PROCESS | 1674 | 05:26:04 INFO - PROCESS | 1674 | __start_tp_report 05:26:04 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 05:26:04 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 05:26:04 INFO - PROCESS | 1674 | |i|pagename|runs| 05:26:04 INFO - PROCESS | 1674 | |0;dojo.html;3444.724422046236;3486.686198242158;3513.5432393788806;3539.8584056637737;3552.6269741677124;5610;5640.520555752761;5651.8587035324135;5660;5731.742071606777;5499.230107784913;5592.636478628886;5624.184493248486;5715.514181294595;5727.770889164439;4456.707554809118;5106.5659418949435;5106.974465127688;5150.768215430296;5218.47815218477;5195.636305458619;5246.317978662769;5250.081235783741;5280.788768449257;5320.388155362144;5019.447860735316;5152.9742351288005;5170.870728231786;5183.870403239912;5204.8959020819375;5105.132127538291;5160.896782064376;5172.612054095958;5195.090859099642;5221.1124108901195;5023.045621331935;5093.567046801027;5124.256982737519;5156.994386094713;5163.199704045879;5431.429699881534;5537.252470916455;5542.9168562471195;5546.223528705985;5575.135853942646;6096.237970253718;6136.447719705203;6163.691815409212;6182.474489668383;6197.597156184834;6121.452973575948;6136.7852125175405;6194.938050619481;6208.534359922979;6226.62640241587;5724.255846739898;5726.31284245889;5737.852429514114;5747.367789543105;5783.5951483396175;6183.319834818167;6189.04069869162;6202.162708034448;6211.440970312694;6224.128621992924;5026;5882.617629854046;6009.939900601025;6073.423024812636;6081.452669259788;6062.999605065115;6069.122219564683;6095.757876457455;6095.770848210712;6113.020255720364;4994.975025124923;5120.743962801845;5838.211841401441;6110.052941793941;6112.473085128069;4811.927821082687;5873.148393482921;6095.451409373178;6133.723982420802;6153.569250152446;4820.662553621213;4825.782839772219;4827.372441582572;4831.685940413862;4835.95164048362;3883.902902427462;4105.692073094529;4321.178975994551;4350.151720414488;4374.846880359172;5526.4197259288;5629.634073785272;5639.125935480007;5645.689487078168;5648.830535083954;5346.331708536433;6100.217864923808;6105.087407201241;6194.101855230966;6207.81376558704;5689.402612725687;5715.828525144252;5719.170720245541;5722.2561067061015;5745.195672605839;5287.7884884604955;5302.867428314245;5315.229291752674;5336.066188417011;5427.29445172133;6124.136831511461;6141.977005061692;6213.37866213375;6244.75020999164;6252.843678908063;6112.663803490851;6152.784652537319;6171;6182.876342473035;6185.134081228722;6139.461473530676;6248.625082495065;6249.0626406039455;6253.96873015632;6256.217972753406;6029.306629737461;6112.362237678745;6124.601900876429;6141.792871882774;6154.969225153845;6153.4154255345675;6185.567010309235;6188.412100850412;6193.163922870355;6195.907061393992;5826.854328641818;5971.552133589911;6063.787767428119;6068.575199735976;6082.817515474543;5988.161657368059;6002.459778619946;6004.549658775697;6010.038393856962;6028.8794224116145;4269.530351661377;5732.369439361751;5823.272090988627;5838.503727183237;5847.356790753099;5442.401335853132;5775.33583637887;5871.266091738533;5888.17565540816;5908.734106965283;5872.735726892215;5878.2064421302575;5878.470937615635;5880.176775251382;5904.911426328523 05:26:04 INFO - PROCESS | 1674 | |1;ext.html;454.8021610599387;540.9783608655654;562.977480900764;601.0233370772495;630.2248234671354;28033.859830700843;29659.851700741492;36825.44761828575;36944;37034.81482592587;37594.872153835364;38220;38228.80885595568;38290.61709382905;38364.42453363202;9251.028641992612;9487.478188699619;9497.335186536946;9516.23870090391;9537.618495260216;9327.39371940825;9619.80760384792;9630.614775408976;9658.32391732579;9687.709368718915;9562.995885432034;9681.273904457194;9696.515174241295;9705.805883882318;9736.75658108546;9543.665971690993;9638.662646807363;9683.854742178873;9701;9716.028397160228;8317.875231871527;9406.200472959807;9577.856332155023;9607.13535781783;9659.517024148765;37033.62966370329;37432;37588.43617345742;37660.24679506422;37721.81139094314;3164.8892288769784;3217.067050555336;3352.9664703352896;3487.546618939547;3535.8939231823088;26796.46407071867;27269.181924542296;27399.315017124532;27578.448431031265;27936.882524698987;2705.1073145862015;2718.25248056784;2726.5364887969095;2822.393185465135;2845.7154284571584;444335;447389.76305118593;448917.75541122415;449716;451557;66503;66729.33270667329;67219;67258.66370668115;67541.66229168823;69175;70572;70800;71151.64424177846;71191.64404177947;16084.195790210442;16195;16331.42840000618;16342.918285408734;16520.504384868473;11113;12293.877061229274;12372.690682733004;12664.936675316565;12738.745225095447;17113;20889.582208355747;20937.685934710993;21296.574068518545;21901.890490547445;9293.535323233811;9534.475603841855;9561.139497445263;9576.95211523952;9583.424994500352;906.8095699902963;979.4906648542718;1040.7242080848582;1046.3721766939775;1105.474899422784;24201;25846.095386661378;28116.8594157032;28290.2927426816;28387;1086.6848613902039;1123.5898896902736;1151.579673419196;1174.5243176513525;1184.1710802438329;14336.641583960276;14389.856101439062;14653.413863445556;14725.55823325302;14757.704845903021;616238;619814;626007;627935;628919.85540072;57996;58140;58601;58656.41343586595;58657.41342586605;1433.5269361110809;1444.2634256529036;1471.6026672798284;1487.4793822162374;1491.2022068193464;27614;27658.861705691343;28167.154985350473;28172.43655126927;28240.71759282381;45668;45823.541764581925;45999.77000114978;46191.76904115458;46265.76867115643;447864;460242;460411;463533;464250;32417.837910810296;32876.50685239676;32924.34151316912;32924.50613240851;33155.171120722174;43667.344989824545;43699.90750231269;44180.337294939956;44436.333454997555;44472.77763611161;28565.571516427684;36440.08899777527;37231;37358.62641373552;37651.493940242086;35466;35704.64295357117;35998;36261.81869090637;36745.448818267214;31376;34972.60109595588;35142.297154056265;35583;35976.10059748423;25402.491950161264;29998.85000574983;30824.537631935986;30877.69122308748;30921.8453907729;19499.70750438773;20427;20995.94223654352;23748.762512374655;24146.75853241445 05:26:04 INFO - PROCESS | 1674 | |2;jquery.html;357.4156254523854;360.62855259083136;367.45799945081006;372.47667027825895;372.9981350093249;14563.635909102277;18535.62928741426;19370.22519099236;19548.609027819453;19978.200871965106;15657.373705051812;20408.285710000117;20514.76911385314;20689.586208275825;20731.792682073174;5713.800016999406;5955.166276721263;5991.520678345743;5994.040953447449;6037.698115094249;4219.451471308726;5851.79518716845;6201.875962480748;6461.0954466374515;6477.319881412454;6394.9680251598675;6402.871942561146;6403.295637479897;6405.807825765211;6414.9679251603675;4865.902681946359;5739.139129130622;5767.682777447239;5768.3654797972185;5768.97115514424;4756.619470442356;5324.1747529133045;5375.16684913839;5375.6774593524515;5495.203195536625;13394.665133371645;13532.932335338359;13568.86431135686;15097.773533397009;24801.883915223858;2052.4766184622977;2134.466383404149;2189.9671504927437;2287.49675071484;2677.6251324814543;9647.758806029835;9717.076877696607;10062;10109.39343639384;10185.745356366077;1684.107423065777;1729.7751292332043;1741.6255505066472;1767.0546257752042;1772.5125590462596;70799;104130;105538.47230763797;107069.46465267702;108406;11348.773024539463;11373.545058197746;11629.59296424621;11642.592509262304;11793.823092653616;13897;13956.441742330193;13963.860361396459;13985.3706583204;13993.16041037541;8552.444091134057;8705.912940870638;8706.825863482822;8782.692605758768;8804.119588041145;8790.25282850952;8841.734747957571;8849.955750221208;8942.016378198394;8943.642254309885;4441;4515.954840451619;4520.751358675238;4538.319252112144;4581.702189357681;1753.5265478320782;1831.825976532254;1858.6468570971472;1870.560418301698;1899.848012159024;860.6772460327377;864.5331520978726;876.4522173641474;879.7419689843457;896.5741272895323;19579.11893964775;19932.103055362542;20128.496787580134;20377.388678339674;20476.59046819085;851.8892543969368;878.9956050219836;907.609727817045;987.9259055570861;997.2072202598806;10941.343519388703;11091.778164436828;11135.719392269993;11243.269187502787;11249.606263780728;534588;537308;537604;589679;604814;74370;113333;114692;115198.42400787942;115590.4220478909;994.651871844863;996.272720913737;1013.4780587997187;1022.6267412394423;1027.7071034755209;18138.818611813713;18334.266629334677;18396.26414943387;18557.16492757856;18561.296054558352;34800.30399392048;50770.74614627051;51009.48990510196;51137;51280.743596281776;62240;68645.65677171582;72574.63712681402;73860.15349616302;74158.2584174173;6739.865202696017;7753.37972962173;7832.960835196015;7985;8199;9889.456079915386;10249.351685617336;12599.622011339674;12718.936405318284;12749.043821713223;10535.104516116216;10778.730531736455;11063.72340691489;11173.88826111761;11252.437378131224;10699.197560182862;10999.945000274947;11008.284461509977;11214.439278035903;11258.605948791754;8959.462432254086;10632.84050739224;11085.778284434105;11234.988851003121;11713.941430292794;7706.499077559941;7956.204379562229;7959.283664470226;7999.600019999093;8297.709580164665;10765.946170269412;10780.460976950964;11079.83380249313;11150.498227579616;11318.886811131782 05:26:04 INFO - PROCESS | 1674 | |3;mootools.html;1526.480996461203;1643.293383844947;1931.8164774346433;2016.2640636167803;2042.836573074154;7987.600619968993;8682.262007729334;8823.647054117835;9002.594883230255;9048;8681.522516261603;8726.65093396265;8760;8761.868571971425;8845.734627961156;2499.587568051274;2506.2982364937757;2512.736162702917;2521.9117330893423;2522.5333313337;2439.316991242455;2509.2346834215555;2510.497900419914;2511.3972646564876;2524.116559204282;2463.3964678653756;2521.9117330893423;2542.6694529711112;2542.9745702542923;2562.654041704374;2498.1631153563576;2527.8356906801;2536.759007894247;2536.8097392695436;2545.9618105728428;2487.403023274401;2507.849529028246;2512.1207577347964;2517.3958250019864;2531.3291977625945;8934.553272336421;8971.102889710977;8973.147550982647;8974.820503589957;8983.056779038237;5394.271773310592;5474.863128421782;5614.242077319551;5632.295963004624;5637.408072152447;3584.5160903277983;3670.2659468106485;3690.7785532868115;3705.110773414361;3748.269087527933;1052.5421441672897;1067.140951534015;1073.6832634372802;1076.3272954403499;1086.5979587552577;12001.159918805688;12008;12059.819102713554;12071.094667899855;12112.031037516977;5000;5011.57401620859;5029.170186919117;5055.064813009605;5064.696118232918;10248.590056397661;10263.794724105626;10295.3822770634;10298;10381.273310868166;5444.346678398539;5483.013057649661;5484.506394424521;5508.173773933861;5577.135543990688;4427.977860110744;4897.045076210176;4953.356063711694;4973;5010.749462526859;4005.1589166274825;4073.4704488416314;4093.2427500912427;4121.9587804122175;4122.670186385082;1352.425219281821;1354.1942544186193;1358.4566173530666;1358.8641135886332;1361.7889227169806;1172.0857730969688;1182.1933374533987;1203.5727316802584;1385.7020740540831;1428.90712103715;8234.835303293901;8252.793680157924;8258.628361723737;8334.416590838704;8394.874076888851;521.3769545393294;522.2349258336556;529.3779808724734;530.7929907336141;535.2506490912754;5256.001359741636;5993.711352059328;6245.125682404467;6409.775657851953;6415.711292991827;7882.763517094496;10225.130863876653;10524.052835244865;10615.469226538642;10720.46397680113;10385;10385.324953877975;10499.895001050045;10500.789984200273;10603.89396106029;8289.461185022954;8367.121452247547;8401.747947561584;8420.705275315335;8482.618282177316;6530.640814755234;6879.58722476653;6898.241193468814;8136.674533018613;8229.012518497819;8524.318054555744;8856;9294.163525282756;9421.764455888384;9522.285828562746;8911.910880891108;9250.334939710916;9650.662226822027;9798.559064841957;10012;6884.036234927014;7326.010988516695;7569.318761311288;7572.962135189288;7709.190534993745;8290.46112002718;8302;8319.043310019184;8319.708810191614;8390.538520381193;7248;7382.26177382279;7393.630318483947;7494.288042635941;7602.391808655184;6460.289368169404;7060.929390706233;7154.284571543012;7180.461465390013;7271.490995630466;7730.226977302224;7804.102528209329;7855.7250496232355;7868.645910934136;7926.564038977912;6975.8604827902145;7031.789046328414;7097.46768992338;7114.608696521741;7115.82210444743;7132.286771322826;7178.461615378972;7192.352688258082;7220.097487814023;7234.5659260444545 05:26:04 INFO - PROCESS | 1674 | |4;prototype.html;288.15426722569254;289.2941223414869;324.1458756177473;332.83690991414204;336.81138562405073;6752.729890804368;6792.2868098849585;6864.17629884414;6920.688569014394;6992.5454845435015;6838.418734407569;6850.897236541456;6853.520253582251;6871.896921546181;6875.381215690587;4833.7099774013495;4892.535209155125;4993.251012348141;5026.447090820006;5081.79672813087;5000.52495012975;5009.924851127236;5029.899402011957;5039.874003149932;5041.647084704072;5005.974970125162;5029.371328583927;5033.345665063555;5035.320231768701;5071.7717702703285;4993.725345106018;5015.949840501585;5022.773975171126;5036.471170527078;5038.420581633086;4302.68768025752;4331.224198078804;4331.610155086058;4332.91334173318;4336.392904993303;5358.062339090644;6337.2395312562785;6377.68111594423;6620.702068406933;6642.867142657168;5902.763889444417;5954.017587098124;5974.790882319098;5976.940230597682;5988.071848863433;7200.495965282433;7251.456140789462;7255.52839065459;7269.345758881673;7270.491065625409;4818.060478206751;4821.831235906727;4826.806927722887;4834.709917404967;4834.8791280218275;7693.422993275527;7693.538387696756;7694.846103077907;7711.807204819868;7750;3878.8836334909997;3947.6775280280854;4529.728216307032;4724.385829842098;4765.642576806753;4807.855764327076;4869.756512174377;4873.537013983666;4875.536824001714;4892.877678058006;5806.274215723035;5836.591438599257;5872.853178670482;5881.235439392852;5892.263467066617;5875.823725288248;7368.926310736824;7393.963030184922;7394.704211831467;7415.258474152542;1396.615930619088;1666.45007147641;1684.1663376628646;1685.401682402754;1688.2909178145208;1034.5499707627055;1071.12703146935;1072.51736718477;1074.4949873559415;1095.9780804384027;6737.59574425536;6788.626625535544;6802.693878775467;6806.149231346082;6825.283345248777;7351.70593176267;7625.199354067743;7763.650635721406;7776.183500732454;7785.532868027936;6673.899891501631;6843.3840954314355;6864.965675171592;6878.071460352889;6928.030075789394;4019.8995025124023;4048.0284731664187;4058.228936502055;4068.3287257602756;4072.5927407259037;6774.322567743285;7645.847083058419;7775.833624956302;8016.759497215093;8070.717524886601;7591.3926885849;7864.4888082274465;7875.527468351917;7894.131645518988;7931.405144614062;6364.427201551883;7963.641636126388;7996;8056.999999999883;8067.03195616518;6627;7255.984162217399;7615.771526854203;7661.846763064819;7699.538027718355;7548.207438218908;7549.3583045439555;7555.622218889143;7558.58427786477;7559.055118110236;7222.96388518075;7760.3791696663;8008.919910801051;8047.195280471906;8074.232947869943;4716.740579268173;4735.408073990751;4765.547273009059;4805.37530121082;4810.759462026955;7620.199879012624;7622.237776222333;7622.809429764078;7627.199144089791;7654.196309387434;6373.968130159319;7025.789226323219;7335.7432489862595;7378.778636640909;7381.298776616213;7173.210946795744;7268.345848873627;7360.852782944418;7387.889181662387;7405.518641288299;7119.6084215368655;7136.750213742494;7152.856942861218;7175.31834475724;7199.82000449972;6274.341194174546;6991.405730512964;7327.230640782641;7333.926660733325;7375.11498620169;6308;6918.411934985381;7172.462065345016;7186.173590037003;7193.676284567103 05:26:04 INFO - PROCESS | 1674 | |5;yui.html;657.2310396835702;665.4111111666174;665.8102440804372;669.8593295407964;732.198242923998;11847;14178;14222.786658200122;14380.712385752291;14577.125372477658;13615.591532254024;13647.317634118304;13647.727045459085;13668.794968075463;13672.726545469084;742.610129681916;905.2893478619269;908.954552272387;940.0834186668012;942.3733217410414;907.4782000349792;928.0580211085753;932.0399988012358;933.8365785987459;935.4854829843592;966.3090890013674;977.9315447918649;982.1259079419323;983.0562659846556;985.1281615770059;947.346331031586;947.3699989507004;967.5839389062701;973.0707174648229;975.1418751498707;706.261956255714;707.6567864585672;707.8230442389403;707.961062141582;718.2960698515432;14646.926765366212;14680.706385872223;14721.926390368088;14841.406343746237;14856.108633481917;12461.501539938392;12475.001999839991;12482.875171248263;12650.74698506034;12719.618411447671;8957.328200384933;9710.077542633438;9732.318737688365;9851.359661622044;9900.554475048568;3548.4677298405186;3553.378158822196;3554.1470047188745;3625.1299688074937;3654.28741395428;55027;80860.59569702172;81249;81677.59161204156;82166;9279.443233406017;9325.487098209527;9332.813343733224;9375.812483750287;9652.662156824617;20598.382048538268;20645.380638580868;20651.793482064986;20656.967151642657;20664.966751662356;5837.445442682938;7029.332213439715;7207.108380868735;7253.673584688701;7334.413246940232;4036.535798383165;4091.263572556909;4102.979485102615;4112.485939257593;4118.279301122351;3491.5984661763714;3545.3795585772386;3577.177249232691;3584.318979393959;3586.049696830342;651.2282944710438;651.7881688451272;658.315352033889;671.2716702377975;672.2034389248756;474.66061765837594;537.6156048425395;555.6999220420928;573.6902072880598;579.4900487570994;7586.772396828104;7894.526328420313;7928.841423171504;8068.636911339004;8123.7156699515235;508.47626944247486;525.7607788456244;528.7726277700625;548.7311217503394;561.1414535760293;3578.624244454347;3721.962780372216;3729.272791805626;3762.5847929280512;3801.3537698590753;77599;78640.60679696564;79052;80984.19015809885;82083;68357.65821170862;68360;68444.6577767108;69514.9572756409;69783;59621.701891490266;60087.39912600818;60165.39834601685;60512.697436512535;60675.69662151661;5843.795467158629;7396.371308438628;7414.480986330905;7422.554646721214;7970.641321140447;43983.78008109939;44620;45599;45778.31332530081;45867.31199032084;47384.7630761844;55052.89894202013;61209;62297.68851155715;62435.43911402251;9388.859167112636;9495;9564.33049686543;9577.329586929127;9892.615033895405;10149.594016239564;10268.332558383681;10405.427701476492;10655.987681170276;11687.240329378563;10761.923807619176;10836.187285953743;10899.56401743953;10940.45297735126;11825.11605690159;10174.491275436347;11158.832617510907;11284.379359135326;11387.259828111146;12366.010719142627;8643.56782160902;9040.367174297999;9213.769655758391;10421.426821524889;11191.608293709682;9168;9329.580168892551;9331.720048398287;9460.337776355589;9543.33196676226;8945.19493245611;9053.728388148365;9253.120953509406;9300.348975571645;9344.859827102735 05:26:04 INFO - PROCESS | 1674 | __end_tp_report 05:26:04 INFO - PROCESS | 1674 | __start_cc_report 05:26:04 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,377 05:26:04 INFO - PROCESS | 1674 | __end_cc_report 05:26:04 INFO - PROCESS | 1674 | __startTimestamp1458822364238__endTimestamp 05:26:04 INFO - PROCESS | 1674 | 05:26:04 INFO - PROCESS | 1674 | ------- Summary: start ------- 05:26:04 INFO - PROCESS | 1674 | Number of tests: 6 05:26:04 INFO - PROCESS | 1674 | 05:26:04 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5618.20 Median:5775.34 stddev:630.84 (10.9%) stddev-sans-first:609.29 05:26:04 INFO - PROCESS | 1674 | Values: 3444.7 3486.7 3513.5 3539.9 3552.6 5610.0 5640.5 5651.9 5660.0 5731.7 5499.2 5592.6 5624.2 5715.5 5727.8 4456.7 5106.6 5107.0 5150.8 5218.5 5195.6 5246.3 5250.1 5280.8 5320.4 5019.4 5153.0 5170.9 5183.9 5204.9 5105.1 5160.9 5172.6 5195.1 5221.1 5023.0 5093.6 5124.3 5157.0 5163.2 5431.4 5537.3 5542.9 5546.2 5575.1 6096.2 6136.4 6163.7 6182.5 6197.6 6121.5 6136.8 6194.9 6208.5 6226.6 5724.3 5726.3 5737.9 5747.4 5783.6 6183.3 6189.0 6202.2 6211.4 6224.1 5026.0 5882.6 6009.9 6073.4 6081.5 6063.0 6069.1 6095.8 6095.8 6113.0 4995.0 5120.7 5838.2 6110.1 6112.5 4811.9 5873.1 6095.5 6133.7 6153.6 4820.7 4825.8 4827.4 4831.7 4836.0 3883.9 4105.7 4321.2 4350.2 4374.8 5526.4 5629.6 5639.1 5645.7 5648.8 5346.3 6100.2 6105.1 6194.1 6207.8 5689.4 5715.8 5719.2 5722.3 5745.2 5287.8 5302.9 5315.2 5336.1 5427.3 6124.1 6142.0 6213.4 6244.8 6252.8 6112.7 6152.8 6171.0 6182.9 6185.1 6139.5 6248.6 6249.1 6254.0 6256.2 6029.3 6112.4 6124.6 6141.8 6155.0 6153.4 6185.6 6188.4 6193.2 6195.9 5826.9 5971.6 6063.8 6068.6 6082.8 5988.2 6002.5 6004.5 6010.0 6028.9 4269.5 5732.4 5823.3 5838.5 5847.4 5442.4 5775.3 5871.3 5888.2 5908.7 5872.7 5878.2 5878.5 5880.2 5904.9 05:26:04 INFO - PROCESS | 1674 | 05:26:04 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:64737.78 Median:37132.91 stddev:137952.83 (371.5%) stddev-sans-first:138255.39 05:26:04 INFO - PROCESS | 1674 | Values: 454.8 541.0 563.0 601.0 630.2 28033.9 29659.9 36825.4 36944.0 37034.8 37594.9 38220.0 38228.8 38290.6 38364.4 9251.0 9487.5 9497.3 9516.2 9537.6 9327.4 9619.8 9630.6 9658.3 9687.7 9563.0 9681.3 9696.5 9705.8 9736.8 9543.7 9638.7 9683.9 9701.0 9716.0 8317.9 9406.2 9577.9 9607.1 9659.5 37033.6 37432.0 37588.4 37660.2 37721.8 3164.9 3217.1 3353.0 3487.5 3535.9 26796.5 27269.2 27399.3 27578.4 27936.9 2705.1 2718.3 2726.5 2822.4 2845.7 444335.0 447389.8 448917.8 449716.0 451557.0 66503.0 66729.3 67219.0 67258.7 67541.7 69175.0 70572.0 70800.0 71151.6 71191.6 16084.2 16195.0 16331.4 16342.9 16520.5 11113.0 12293.9 12372.7 12664.9 12738.7 17113.0 20889.6 20937.7 21296.6 21901.9 9293.5 9534.5 9561.1 9577.0 9583.4 906.8 979.5 1040.7 1046.4 1105.5 24201.0 25846.1 28116.9 28290.3 28387.0 1086.7 1123.6 1151.6 1174.5 1184.2 14336.6 14389.9 14653.4 14725.6 14757.7 616238.0 619814.0 626007.0 627935.0 628919.9 57996.0 58140.0 58601.0 58656.4 58657.4 1433.5 1444.3 1471.6 1487.5 1491.2 27614.0 27658.9 28167.2 28172.4 28240.7 45668.0 45823.5 45999.8 46191.8 46265.8 447864.0 460242.0 460411.0 463533.0 464250.0 32417.8 32876.5 32924.3 32924.5 33155.2 43667.3 43699.9 44180.3 44436.3 44472.8 28565.6 36440.1 37231.0 37358.6 37651.5 35466.0 35704.6 35998.0 36261.8 36745.4 31376.0 34972.6 35142.3 35583.0 35976.1 25402.5 29998.9 30824.5 30877.7 30921.8 19499.7 20427.0 20995.9 23748.8 24146.8 05:26:04 INFO - PROCESS | 1674 | 05:26:04 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:32086.68 Median:13739.75 stddev:93160.76 (678.0%) stddev-sans-first:93391.64 05:26:04 INFO - PROCESS | 1674 | Values: 357.4 360.6 367.5 372.5 373.0 14563.6 18535.6 19370.2 19548.6 19978.2 15657.4 20408.3 20514.8 20689.6 20731.8 5713.8 5955.2 5991.5 5994.0 6037.7 4219.5 5851.8 6201.9 6461.1 6477.3 6395.0 6402.9 6403.3 6405.8 6415.0 4865.9 5739.1 5767.7 5768.4 5769.0 4756.6 5324.2 5375.2 5375.7 5495.2 13394.7 13532.9 13568.9 15097.8 24801.9 2052.5 2134.5 2190.0 2287.5 2677.6 9647.8 9717.1 10062.0 10109.4 10185.7 1684.1 1729.8 1741.6 1767.1 1772.5 70799.0 104130.0 105538.5 107069.5 108406.0 11348.8 11373.5 11629.6 11642.6 11793.8 13897.0 13956.4 13963.9 13985.4 13993.2 8552.4 8705.9 8706.8 8782.7 8804.1 8790.3 8841.7 8850.0 8942.0 8943.6 4441.0 4516.0 4520.8 4538.3 4581.7 1753.5 1831.8 1858.6 1870.6 1899.8 860.7 864.5 876.5 879.7 896.6 19579.1 19932.1 20128.5 20377.4 20476.6 851.9 879.0 907.6 987.9 997.2 10941.3 11091.8 11135.7 11243.3 11249.6 534588.0 537308.0 537604.0 589679.0 604814.0 74370.0 113333.0 114692.0 115198.4 115590.4 994.7 996.3 1013.5 1022.6 1027.7 18138.8 18334.3 18396.3 18557.2 18561.3 34800.3 50770.7 51009.5 51137.0 51280.7 62240.0 68645.7 72574.6 73860.2 74158.3 6739.9 7753.4 7833.0 7985.0 8199.0 9889.5 10249.4 12599.6 12718.9 12749.0 10535.1 10778.7 11063.7 11173.9 11252.4 10699.2 10999.9 11008.3 11214.4 11258.6 8959.5 10632.8 11085.8 11235.0 11713.9 7706.5 7956.2 7959.3 7999.6 8297.7 10765.9 10780.5 11079.8 11150.5 11318.9 05:26:04 INFO - PROCESS | 1674 | 05:26:04 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:6044.54 Median:2964.76 stddev:3156.29 (106.5%) stddev-sans-first:3146.88 05:26:04 INFO - PROCESS | 1674 | Values: 1526.5 1643.3 1931.8 2016.3 2042.8 7987.6 8682.3 8823.6 9002.6 9048.0 8681.5 8726.7 8760.0 8761.9 8845.7 2499.6 2506.3 2512.7 2521.9 2522.5 2439.3 2509.2 2510.5 2511.4 2524.1 2463.4 2521.9 2542.7 2543.0 2562.7 2498.2 2527.8 2536.8 2536.8 2546.0 2487.4 2507.8 2512.1 2517.4 2531.3 8934.6 8971.1 8973.1 8974.8 8983.1 5394.3 5474.9 5614.2 5632.3 5637.4 3584.5 3670.3 3690.8 3705.1 3748.3 1052.5 1067.1 1073.7 1076.3 1086.6 12001.2 12008.0 12059.8 12071.1 12112.0 5000.0 5011.6 5029.2 5055.1 5064.7 10248.6 10263.8 10295.4 10298.0 10381.3 5444.3 5483.0 5484.5 5508.2 5577.1 4428.0 4897.0 4953.4 4973.0 5010.7 4005.2 4073.5 4093.2 4122.0 4122.7 1352.4 1354.2 1358.5 1358.9 1361.8 1172.1 1182.2 1203.6 1385.7 1428.9 8234.8 8252.8 8258.6 8334.4 8394.9 521.4 522.2 529.4 530.8 535.3 5256.0 5993.7 6245.1 6409.8 6415.7 7882.8 10225.1 10524.1 10615.5 10720.5 10385.0 10385.3 10499.9 10500.8 10603.9 8289.5 8367.1 8401.7 8420.7 8482.6 6530.6 6879.6 6898.2 8136.7 8229.0 8524.3 8856.0 9294.2 9421.8 9522.3 8911.9 9250.3 9650.7 9798.6 10012.0 6884.0 7326.0 7569.3 7573.0 7709.2 8290.5 8302.0 8319.0 8319.7 8390.5 7248.0 7382.3 7393.6 7494.3 7602.4 6460.3 7060.9 7154.3 7180.5 7271.5 7730.2 7804.1 7855.7 7868.6 7926.6 6975.9 7031.8 7097.5 7114.6 7115.8 7132.3 7178.5 7192.4 7220.1 7234.6 05:26:04 INFO - PROCESS | 1674 | 05:26:04 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:5959.85 Median:6790.46 stddev:1921.28 (28.3%) stddev-sans-first:1878.92 05:26:04 INFO - PROCESS | 1674 | Values: 288.2 289.3 324.1 332.8 336.8 6752.7 6792.3 6864.2 6920.7 6992.5 6838.4 6850.9 6853.5 6871.9 6875.4 4833.7 4892.5 4993.3 5026.4 5081.8 5000.5 5009.9 5029.9 5039.9 5041.6 5006.0 5029.4 5033.3 5035.3 5071.8 4993.7 5015.9 5022.8 5036.5 5038.4 4302.7 4331.2 4331.6 4332.9 4336.4 5358.1 6337.2 6377.7 6620.7 6642.9 5902.8 5954.0 5974.8 5976.9 5988.1 7200.5 7251.5 7255.5 7269.3 7270.5 4818.1 4821.8 4826.8 4834.7 4834.9 7693.4 7693.5 7694.8 7711.8 7750.0 3878.9 3947.7 4529.7 4724.4 4765.6 4807.9 4869.8 4873.5 4875.5 4892.9 5806.3 5836.6 5872.9 5881.2 5892.3 5875.8 7368.9 7394.0 7394.7 7415.3 1396.6 1666.5 1684.2 1685.4 1688.3 1034.5 1071.1 1072.5 1074.5 1096.0 6737.6 6788.6 6802.7 6806.1 6825.3 7351.7 7625.2 7763.7 7776.2 7785.5 6673.9 6843.4 6865.0 6878.1 6928.0 4019.9 4048.0 4058.2 4068.3 4072.6 6774.3 7645.8 7775.8 8016.8 8070.7 7591.4 7864.5 7875.5 7894.1 7931.4 6364.4 7963.6 7996.0 8057.0 8067.0 6627.0 7256.0 7615.8 7661.8 7699.5 7548.2 7549.4 7555.6 7558.6 7559.1 7223.0 7760.4 8008.9 8047.2 8074.2 4716.7 4735.4 4765.5 4805.4 4810.8 7620.2 7622.2 7622.8 7627.2 7654.2 6374.0 7025.8 7335.7 7378.8 7381.3 7173.2 7268.3 7360.9 7387.9 7405.5 7119.6 7136.8 7152.9 7175.3 7199.8 6274.3 6991.4 7327.2 7333.9 7375.1 6308.0 6918.4 7172.5 7186.2 7193.7 05:26:04 INFO - PROCESS | 1674 | 05:26:04 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:16582.70 Median:651.51 stddev:22702.33 (3484.6%) stddev-sans-first:22734.52 05:26:04 INFO - PROCESS | 1674 | Values: 657.2 665.4 665.8 669.9 732.2 11847.0 14178.0 14222.8 14380.7 14577.1 13615.6 13647.3 13647.7 13668.8 13672.7 742.6 905.3 909.0 940.1 942.4 907.5 928.1 932.0 933.8 935.5 966.3 977.9 982.1 983.1 985.1 947.3 947.4 967.6 973.1 975.1 706.3 707.7 707.8 708.0 718.3 14646.9 14680.7 14721.9 14841.4 14856.1 12461.5 12475.0 12482.9 12650.7 12719.6 8957.3 9710.1 9732.3 9851.4 9900.6 3548.5 3553.4 3554.1 3625.1 3654.3 55027.0 80860.6 81249.0 81677.6 82166.0 9279.4 9325.5 9332.8 9375.8 9652.7 20598.4 20645.4 20651.8 20657.0 20665.0 5837.4 7029.3 7207.1 7253.7 7334.4 4036.5 4091.3 4103.0 4112.5 4118.3 3491.6 3545.4 3577.2 3584.3 3586.0 651.2 651.8 658.3 671.3 672.2 474.7 537.6 555.7 573.7 579.5 7586.8 7894.5 7928.8 8068.6 8123.7 508.5 525.8 528.8 548.7 561.1 3578.6 3722.0 3729.3 3762.6 3801.4 77599.0 78640.6 79052.0 80984.2 82083.0 68357.7 68360.0 68444.7 69515.0 69783.0 59621.7 60087.4 60165.4 60512.7 60675.7 5843.8 7396.4 7414.5 7422.6 7970.6 43983.8 44620.0 45599.0 45778.3 45867.3 47384.8 55052.9 61209.0 62297.7 62435.4 9388.9 9495.0 9564.3 9577.3 9892.6 10149.6 10268.3 10405.4 10656.0 11687.2 10761.9 10836.2 10899.6 10940.5 11825.1 10174.5 11158.8 11284.4 11387.3 12366.0 8643.6 9040.4 9213.8 10421.4 11191.6 9168.0 9329.6 9331.7 9460.3 9543.3 8945.2 9053.7 9253.1 9300.3 9344.9 05:26:04 INFO - PROCESS | 1674 | -------- Summary: end -------- 05:26:04 INFO - PROCESS | 1674 | 05:26:04 INFO - TEST-INFO | 1674: exit 0 05:26:04 INFO - TEST-OK | dromaeo_css | took 1110742ms 05:26:04 INFO - TEST-START | kraken 05:26:04 INFO - operating with platform_type : mac_ 05:26:04 INFO - Initialising browser for kraken test... 05:26:04 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpf0k8Vv/profile http://localhost:49270/getInfo.html) 05:26:07 INFO - PROCESS | 1681 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:26:07 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 05:26:07 INFO - PROCESS | 1681 | colorDepth:24 05:26:07 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 05:26:07 INFO - PROCESS | 1681 | __metrics 05:26:07 ERROR - PROCESS | 1681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 05:26:08 INFO - TEST-INFO | 1681: exit 0 05:26:08 INFO - Browser initialized. 05:26:08 INFO - Running cycle 1/1 for kraken test... 05:26:08 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpf0k8Vv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:20 INFO - PROCESS | 1684 | RSS: Main: 258048000 05:26:20 INFO - PROCESS | 1684 | 05:26:23 INFO - PROCESS | 1684 | 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) 05:26:23 INFO - PROCESS | 1684 | RSS: Main: 270352384 05:26:23 INFO - PROCESS | 1684 | 05:26:26 INFO - PROCESS | 1684 | 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) 05:26:27 INFO - PROCESS | 1684 | RSS: Main: 277643264 05:26:27 INFO - PROCESS | 1684 | 05:26:30 INFO - PROCESS | 1684 | 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) 05:26:31 INFO - PROCESS | 1684 | RSS: Main: 282439680 05:26:31 INFO - PROCESS | 1684 | 05:26:33 INFO - PROCESS | 1684 | 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) 05:26:33 INFO - PROCESS | 1684 | RSS: Main: 283611136 05:26:33 INFO - PROCESS | 1684 | 05:26:35 INFO - PROCESS | 1684 | 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) 05:26:36 INFO - PROCESS | 1684 | RSS: Main: 284348416 05:26:36 INFO - PROCESS | 1684 | 05:26:39 INFO - PROCESS | 1684 | 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) 05:26:39 INFO - PROCESS | 1684 | RSS: Main: 283668480 05:26:39 INFO - PROCESS | 1684 | 05:26:42 INFO - PROCESS | 1684 | 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) 05:26:43 INFO - PROCESS | 1684 | RSS: Main: 283480064 05:26:43 INFO - PROCESS | 1684 | 05:26:46 INFO - PROCESS | 1684 | 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) 05:26:46 INFO - PROCESS | 1684 | RSS: Main: 283574272 05:26:46 INFO - PROCESS | 1684 | 05:26:48 INFO - PROCESS | 1684 | 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) 05:26:49 INFO - PROCESS | 1684 | RSS: Main: 282304512 05:26:49 INFO - PROCESS | 1684 | 05:26:50 INFO - PROCESS | 1684 | 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) 05:26:51 INFO - PROCESS | 1684 | RSS: Main: 283824128 05:26:51 INFO - PROCESS | 1684 | 05:26:53 INFO - PROCESS | 1684 | 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) 05:26:54 INFO - PROCESS | 1684 | RSS: Main: 284155904 05:26:54 INFO - PROCESS | 1684 | 05:26:56 INFO - PROCESS | 1684 | 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) 05:26:57 INFO - PROCESS | 1684 | RSS: Main: 286093312 05:26:57 INFO - PROCESS | 1684 | 05:27:00 INFO - PROCESS | 1684 | 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) 05:27:00 INFO - PROCESS | 1684 | RSS: Main: 286019584 05:27:00 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | 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) 05:27:02 INFO - PROCESS | 1684 | RSS: Main: 285880320 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | __start_tp_report 05:27:02 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 05:27:02 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 05:27:02 INFO - PROCESS | 1684 | |i|pagename|runs| 05:27:02 INFO - PROCESS | 1684 | |0;ai-astar;116;109;116;115;130;185;156;113;120;164 05:27:02 INFO - PROCESS | 1684 | |1;audio-beat-detection;149;125;141;172;107;166;175;148;178;122 05:27:02 INFO - PROCESS | 1684 | |2;audio-dft;195;199;196;216;217;272;244;196;245;274 05:27:02 INFO - PROCESS | 1684 | |3;audio-fft;66;90;94;147;58;57;62;60;124;77 05:27:02 INFO - PROCESS | 1684 | |4;audio-oscillator;81;89;122;79;82;80;122;82;79;113 05:27:02 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;90;88;89;87;100;128;91;88;89;101 05:27:02 INFO - PROCESS | 1684 | |6;imaging-darkroom;139;96;96;96;95;95;95;97;93;97 05:27:02 INFO - PROCESS | 1684 | |7;imaging-desaturate;91;92;115;118;100;92;90;93;92;90 05:27:02 INFO - PROCESS | 1684 | |8;json-parse-financial;56;58;58;57;59;58;56;66;58;61 05:27:02 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;68;70;67;71;66;67;67;67;68;72 05:27:02 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;86;83;85;77;91;109;106;95;85;82 05:27:02 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;124;140;142;107;125;149;141;130;135;136 05:27:02 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;133;144;142;144;142;130;142;144;142;138 05:27:02 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;70;70;66;69;69;68;66;68;67;69 05:27:02 INFO - PROCESS | 1684 | __end_tp_report 05:27:02 INFO - PROCESS | 1684 | __start_cc_report 05:27:02 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,946 05:27:02 INFO - PROCESS | 1684 | __end_cc_report 05:27:02 INFO - PROCESS | 1684 | __startTimestamp1458822422547__endTimestamp 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | ------- Summary: start ------- 05:27:02 INFO - PROCESS | 1684 | Number of tests: 14 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:132.40 Median:125.00 stddev:26.34 (21.1%) stddev-sans-first:27.27 05:27:02 INFO - PROCESS | 1684 | Values: 116.0 109.0 116.0 115.0 130.0 185.0 156.0 113.0 120.0 164.0 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:157.50 stddev:24.64 (15.6%) stddev-sans-first:26.13 05:27:02 INFO - PROCESS | 1684 | Values: 149.0 125.0 141.0 172.0 107.0 166.0 175.0 148.0 178.0 122.0 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:225.40 Median:230.50 stddev:31.22 (13.5%) stddev-sans-first:31.12 05:27:02 INFO - PROCESS | 1684 | Values: 195.0 199.0 196.0 216.0 217.0 272.0 244.0 196.0 245.0 274.0 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:83.50 Median:64.00 stddev:30.80 (48.1%) stddev-sans-first:32.02 05:27:02 INFO - PROCESS | 1684 | Values: 66.0 90.0 94.0 147.0 58.0 57.0 62.0 60.0 124.0 77.0 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:80.50 stddev:18.39 (22.8%) stddev-sans-first:19.00 05:27:02 INFO - PROCESS | 1684 | Values: 81.0 89.0 122.0 79.0 82.0 80.0 122.0 82.0 79.0 113.0 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:88.50 stddev:12.58 (14.2%) stddev-sans-first:13.21 05:27:02 INFO - PROCESS | 1684 | Values: 90.0 88.0 89.0 87.0 100.0 128.0 91.0 88.0 89.0 101.0 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:96.00 stddev:13.79 (14.4%) stddev-sans-first:1.24 05:27:02 INFO - PROCESS | 1684 | Values: 139.0 96.0 96.0 96.0 95.0 95.0 95.0 97.0 93.0 97.0 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:91.50 stddev:10.53 (11.5%) stddev-sans-first:10.92 05:27:02 INFO - PROCESS | 1684 | Values: 91.0 92.0 115.0 118.0 100.0 92.0 90.0 93.0 92.0 90.0 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:58.00 stddev:2.95 (5.1%) stddev-sans-first:2.96 05:27:02 INFO - PROCESS | 1684 | Values: 56.0 58.0 58.0 57.0 59.0 58.0 56.0 66.0 58.0 61.0 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:2.00 (2.9%) stddev-sans-first:2.12 05:27:02 INFO - PROCESS | 1684 | Values: 68.0 70.0 67.0 71.0 66.0 67.0 67.0 67.0 68.0 72.0 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:85.00 stddev:10.49 (12.3%) stddev-sans-first:11.03 05:27:02 INFO - PROCESS | 1684 | Values: 86.0 83.0 85.0 77.0 91.0 109.0 106.0 95.0 85.0 82.0 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:138.00 stddev:11.99 (8.7%) stddev-sans-first:12.27 05:27:02 INFO - PROCESS | 1684 | Values: 124.0 140.0 142.0 107.0 125.0 149.0 141.0 130.0 135.0 136.0 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.10 Median:142.00 stddev:4.91 (3.5%) stddev-sans-first:4.48 05:27:02 INFO - PROCESS | 1684 | Values: 133.0 144.0 142.0 144.0 142.0 130.0 142.0 144.0 142.0 138.0 05:27:02 INFO - PROCESS | 1684 | 05:27:02 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.48 (2.1%) stddev-sans-first:1.41 05:27:02 INFO - PROCESS | 1684 | Values: 70.0 70.0 66.0 69.0 69.0 68.0 66.0 68.0 67.0 69.0 05:27:02 INFO - PROCESS | 1684 | -------- Summary: end -------- 05:27:02 INFO - PROCESS | 1684 | 05:27:03 INFO - TEST-INFO | 1684: exit 0 05:27:03 INFO - TEST-OK | kraken | took 58508ms 05:27:03 INFO - SUITE-END | took 1169s 05:27:03 INFO - Completed test suite (00:19:29) 05:27:03 INFO - javascript benchmark 05:27:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3444.724422046236, 3486.686198242158, 3513.5432393788806, 3539.8584056637737, 3552.6269741677124, 5610.0, 5640.520555752761, 5651.8587035324135, 5660.0, 5731.742071606777, 5499.230107784913, 5592.636478628886, 5624.184493248486, 5715.514181294595, 5727.770889164439, 4456.707554809118, 5106.5659418949435, 5106.974465127688, 5150.768215430296, 5218.47815218477, 5195.636305458619, 5246.317978662769, 5250.081235783741, 5280.788768449257, 5320.388155362144, 5019.447860735316, 5152.9742351288005, 5170.870728231786, 5183.870403239912, 5204.8959020819375, 5105.132127538291, 5160.896782064376, 5172.612054095958, 5195.090859099642, 5221.1124108901195, 5023.045621331935, 5093.567046801027, 5124.256982737519, 5156.994386094713, 5163.199704045879, 5431.429699881534, 5537.252470916455, 5542.9168562471195, 5546.223528705985, 5575.135853942646, 6096.237970253718, 6136.447719705203, 6163.691815409212, 6182.474489668383, 6197.597156184834, 6121.452973575948, 6136.7852125175405, 6194.938050619481, 6208.534359922979, 6226.62640241587, 5724.255846739898, 5726.31284245889, 5737.852429514114, 5747.367789543105, 5783.5951483396175, 6183.319834818167, 6189.04069869162, 6202.162708034448, 6211.440970312694, 6224.128621992924, 5026.0, 5882.617629854046, 6009.939900601025, 6073.423024812636, 6081.452669259788, 6062.999605065115, 6069.122219564683, 6095.757876457455, 6095.770848210712, 6113.020255720364, 4994.975025124923, 5120.743962801845, 5838.211841401441, 6110.052941793941, 6112.473085128069, 4811.927821082687, 5873.148393482921, 6095.451409373178, 6133.723982420802, 6153.569250152446, 4820.662553621213, 4825.782839772219, 4827.372441582572, 4831.685940413862, 4835.95164048362, 3883.902902427462, 4105.692073094529, 4321.178975994551, 4350.151720414488, 4374.846880359172, 5526.4197259288, 5629.634073785272, 5639.125935480007, 5645.689487078168, 5648.830535083954, 5346.331708536433, 6100.217864923808, 6105.087407201241, 6194.101855230966, 6207.81376558704, 5689.402612725687, 5715.828525144252, 5719.170720245541, 5722.2561067061015, 5745.195672605839, 5287.7884884604955, 5302.867428314245, 5315.229291752674, 5336.066188417011, 5427.29445172133, 6124.136831511461, 6141.977005061692, 6213.37866213375, 6244.75020999164, 6252.843678908063, 6112.663803490851, 6152.784652537319, 6171.0, 6182.876342473035, 6185.134081228722, 6139.461473530676, 6248.625082495065, 6249.0626406039455, 6253.96873015632, 6256.217972753406, 6029.306629737461, 6112.362237678745, 6124.601900876429, 6141.792871882774, 6154.969225153845, 6153.4154255345675, 6185.567010309235, 6188.412100850412, 6193.163922870355, 6195.907061393992, 5826.854328641818, 5971.552133589911, 6063.787767428119, 6068.575199735976, 6082.817515474543, 5988.161657368059, 6002.459778619946, 6004.549658775697, 6010.038393856962, 6028.8794224116145, 4269.530351661377, 5732.369439361751, 5823.272090988627, 5838.503727183237, 5847.356790753099, 5442.401335853132, 5775.33583637887, 5871.266091738533, 5888.17565540816, 5908.734106965283, 5872.735726892215, 5878.2064421302575, 5878.470937615635, 5880.176775251382, 5904.911426328523], "unit": "score", "name": "dojo.html", "value": 5581.503152413614}, {"lowerIsBetter": false, "replicates": [454.8021610599387, 540.9783608655654, 562.977480900764, 601.0233370772495, 630.2248234671354, 28033.859830700843, 29659.851700741492, 36825.44761828575, 36944.0, 37034.81482592587, 37594.872153835364, 38220.0, 38228.80885595568, 38290.61709382905, 38364.42453363202, 9251.028641992612, 9487.478188699619, 9497.335186536946, 9516.23870090391, 9537.618495260216, 9327.39371940825, 9619.80760384792, 9630.614775408976, 9658.32391732579, 9687.709368718915, 9562.995885432034, 9681.273904457194, 9696.515174241295, 9705.805883882318, 9736.75658108546, 9543.665971690993, 9638.662646807363, 9683.854742178873, 9701.0, 9716.028397160228, 8317.875231871527, 9406.200472959807, 9577.856332155023, 9607.13535781783, 9659.517024148765, 37033.62966370329, 37432.0, 37588.43617345742, 37660.24679506422, 37721.81139094314, 3164.8892288769784, 3217.067050555336, 3352.9664703352896, 3487.546618939547, 3535.8939231823088, 26796.46407071867, 27269.181924542296, 27399.315017124532, 27578.448431031265, 27936.882524698987, 2705.1073145862015, 2718.25248056784, 2726.5364887969095, 2822.393185465135, 2845.7154284571584, 444335.0, 447389.76305118593, 448917.75541122415, 449716.0, 451557.0, 66503.0, 66729.33270667329, 67219.0, 67258.66370668115, 67541.66229168823, 69175.0, 70572.0, 70800.0, 71151.64424177846, 71191.64404177947, 16084.195790210442, 16195.0, 16331.42840000618, 16342.918285408734, 16520.504384868473, 11113.0, 12293.877061229274, 12372.690682733004, 12664.936675316565, 12738.745225095447, 17113.0, 20889.582208355747, 20937.685934710993, 21296.574068518545, 21901.890490547445, 9293.535323233811, 9534.475603841855, 9561.139497445263, 9576.95211523952, 9583.424994500352, 906.8095699902963, 979.4906648542718, 1040.7242080848582, 1046.3721766939775, 1105.474899422784, 24201.0, 25846.095386661378, 28116.8594157032, 28290.2927426816, 28387.0, 1086.6848613902039, 1123.5898896902736, 1151.579673419196, 1174.5243176513525, 1184.1710802438329, 14336.641583960276, 14389.856101439062, 14653.413863445556, 14725.55823325302, 14757.704845903021, 616238.0, 619814.0, 626007.0, 627935.0, 628919.85540072, 57996.0, 58140.0, 58601.0, 58656.41343586595, 58657.41342586605, 1433.5269361110809, 1444.2634256529036, 1471.6026672798284, 1487.4793822162374, 1491.2022068193464, 27614.0, 27658.861705691343, 28167.154985350473, 28172.43655126927, 28240.71759282381, 45668.0, 45823.541764581925, 45999.77000114978, 46191.76904115458, 46265.76867115643, 447864.0, 460242.0, 460411.0, 463533.0, 464250.0, 32417.837910810296, 32876.50685239676, 32924.34151316912, 32924.50613240851, 33155.171120722174, 43667.344989824545, 43699.90750231269, 44180.337294939956, 44436.333454997555, 44472.77763611161, 28565.571516427684, 36440.08899777527, 37231.0, 37358.62641373552, 37651.493940242086, 35466.0, 35704.64295357117, 35998.0, 36261.81869090637, 36745.448818267214, 31376.0, 34972.60109595588, 35142.297154056265, 35583.0, 35976.10059748423, 25402.491950161264, 29998.85000574983, 30824.537631935986, 30877.69122308748, 30921.8453907729, 19499.70750438773, 20427.0, 20995.94223654352, 23748.762512374655, 24146.75853241445], "unit": "score", "name": "ext.html", "value": 19476.08437534877}, {"lowerIsBetter": false, "replicates": [357.4156254523854, 360.62855259083136, 367.45799945081006, 372.47667027825895, 372.9981350093249, 14563.635909102277, 18535.62928741426, 19370.22519099236, 19548.609027819453, 19978.200871965106, 15657.373705051812, 20408.285710000117, 20514.76911385314, 20689.586208275825, 20731.792682073174, 5713.800016999406, 5955.166276721263, 5991.520678345743, 5994.040953447449, 6037.698115094249, 4219.451471308726, 5851.79518716845, 6201.875962480748, 6461.0954466374515, 6477.319881412454, 6394.9680251598675, 6402.871942561146, 6403.295637479897, 6405.807825765211, 6414.9679251603675, 4865.902681946359, 5739.139129130622, 5767.682777447239, 5768.3654797972185, 5768.97115514424, 4756.619470442356, 5324.1747529133045, 5375.16684913839, 5375.6774593524515, 5495.203195536625, 13394.665133371645, 13532.932335338359, 13568.86431135686, 15097.773533397009, 24801.883915223858, 2052.4766184622977, 2134.466383404149, 2189.9671504927437, 2287.49675071484, 2677.6251324814543, 9647.758806029835, 9717.076877696607, 10062.0, 10109.39343639384, 10185.745356366077, 1684.107423065777, 1729.7751292332043, 1741.6255505066472, 1767.0546257752042, 1772.5125590462596, 70799.0, 104130.0, 105538.47230763797, 107069.46465267702, 108406.0, 11348.773024539463, 11373.545058197746, 11629.59296424621, 11642.592509262304, 11793.823092653616, 13897.0, 13956.441742330193, 13963.860361396459, 13985.3706583204, 13993.16041037541, 8552.444091134057, 8705.912940870638, 8706.825863482822, 8782.692605758768, 8804.119588041145, 8790.25282850952, 8841.734747957571, 8849.955750221208, 8942.016378198394, 8943.642254309885, 4441.0, 4515.954840451619, 4520.751358675238, 4538.319252112144, 4581.702189357681, 1753.5265478320782, 1831.825976532254, 1858.6468570971472, 1870.560418301698, 1899.848012159024, 860.6772460327377, 864.5331520978726, 876.4522173641474, 879.7419689843457, 896.5741272895323, 19579.11893964775, 19932.103055362542, 20128.496787580134, 20377.388678339674, 20476.59046819085, 851.8892543969368, 878.9956050219836, 907.609727817045, 987.9259055570861, 997.2072202598806, 10941.343519388703, 11091.778164436828, 11135.719392269993, 11243.269187502787, 11249.606263780728, 534588.0, 537308.0, 537604.0, 589679.0, 604814.0, 74370.0, 113333.0, 114692.0, 115198.42400787942, 115590.4220478909, 994.651871844863, 996.272720913737, 1013.4780587997187, 1022.6267412394423, 1027.7071034755209, 18138.818611813713, 18334.266629334677, 18396.26414943387, 18557.16492757856, 18561.296054558352, 34800.30399392048, 50770.74614627051, 51009.48990510196, 51137.0, 51280.743596281776, 62240.0, 68645.65677171582, 72574.63712681402, 73860.15349616302, 74158.2584174173, 6739.865202696017, 7753.37972962173, 7832.960835196015, 7985.0, 8199.0, 9889.456079915386, 10249.351685617336, 12599.622011339674, 12718.936405318284, 12749.043821713223, 10535.104516116216, 10778.730531736455, 11063.72340691489, 11173.88826111761, 11252.437378131224, 10699.197560182862, 10999.945000274947, 11008.284461509977, 11214.439278035903, 11258.605948791754, 8959.462432254086, 10632.84050739224, 11085.778284434105, 11234.988851003121, 11713.941430292794, 7706.499077559941, 7956.204379562229, 7959.283664470226, 7999.600019999093, 8297.709580164665, 10765.946170269412, 10780.460976950964, 11079.83380249313, 11150.498227579616, 11318.886811131782], "unit": "score", "name": "jquery.html", "value": 9138.734282918052}, {"lowerIsBetter": false, "replicates": [1526.480996461203, 1643.293383844947, 1931.8164774346433, 2016.2640636167803, 2042.836573074154, 7987.600619968993, 8682.262007729334, 8823.647054117835, 9002.594883230255, 9048.0, 8681.522516261603, 8726.65093396265, 8760.0, 8761.868571971425, 8845.734627961156, 2499.587568051274, 2506.2982364937757, 2512.736162702917, 2521.9117330893423, 2522.5333313337, 2439.316991242455, 2509.2346834215555, 2510.497900419914, 2511.3972646564876, 2524.116559204282, 2463.3964678653756, 2521.9117330893423, 2542.6694529711112, 2542.9745702542923, 2562.654041704374, 2498.1631153563576, 2527.8356906801, 2536.759007894247, 2536.8097392695436, 2545.9618105728428, 2487.403023274401, 2507.849529028246, 2512.1207577347964, 2517.3958250019864, 2531.3291977625945, 8934.553272336421, 8971.102889710977, 8973.147550982647, 8974.820503589957, 8983.056779038237, 5394.271773310592, 5474.863128421782, 5614.242077319551, 5632.295963004624, 5637.408072152447, 3584.5160903277983, 3670.2659468106485, 3690.7785532868115, 3705.110773414361, 3748.269087527933, 1052.5421441672897, 1067.140951534015, 1073.6832634372802, 1076.3272954403499, 1086.5979587552577, 12001.159918805688, 12008.0, 12059.819102713554, 12071.094667899855, 12112.031037516977, 5000.0, 5011.57401620859, 5029.170186919117, 5055.064813009605, 5064.696118232918, 10248.590056397661, 10263.794724105626, 10295.3822770634, 10298.0, 10381.273310868166, 5444.346678398539, 5483.013057649661, 5484.506394424521, 5508.173773933861, 5577.135543990688, 4427.977860110744, 4897.045076210176, 4953.356063711694, 4973.0, 5010.749462526859, 4005.1589166274825, 4073.4704488416314, 4093.2427500912427, 4121.9587804122175, 4122.670186385082, 1352.425219281821, 1354.1942544186193, 1358.4566173530666, 1358.8641135886332, 1361.7889227169806, 1172.0857730969688, 1182.1933374533987, 1203.5727316802584, 1385.7020740540831, 1428.90712103715, 8234.835303293901, 8252.793680157924, 8258.628361723737, 8334.416590838704, 8394.874076888851, 521.3769545393294, 522.2349258336556, 529.3779808724734, 530.7929907336141, 535.2506490912754, 5256.001359741636, 5993.711352059328, 6245.125682404467, 6409.775657851953, 6415.711292991827, 7882.763517094496, 10225.130863876653, 10524.052835244865, 10615.469226538642, 10720.46397680113, 10385.0, 10385.324953877975, 10499.895001050045, 10500.789984200273, 10603.89396106029, 8289.461185022954, 8367.121452247547, 8401.747947561584, 8420.705275315335, 8482.618282177316, 6530.640814755234, 6879.58722476653, 6898.241193468814, 8136.674533018613, 8229.012518497819, 8524.318054555744, 8856.0, 9294.163525282756, 9421.764455888384, 9522.285828562746, 8911.910880891108, 9250.334939710916, 9650.662226822027, 9798.559064841957, 10012.0, 6884.036234927014, 7326.010988516695, 7569.318761311288, 7572.962135189288, 7709.190534993745, 8290.46112002718, 8302.0, 8319.043310019184, 8319.708810191614, 8390.538520381193, 7248.0, 7382.26177382279, 7393.630318483947, 7494.288042635941, 7602.391808655184, 6460.289368169404, 7060.929390706233, 7154.284571543012, 7180.461465390013, 7271.490995630466, 7730.226977302224, 7804.102528209329, 7855.7250496232355, 7868.645910934136, 7926.564038977912, 6975.8604827902145, 7031.789046328414, 7097.46768992338, 7114.608696521741, 7115.82210444743, 7132.286771322826, 7178.461615378972, 7192.352688258082, 7220.097487814023, 7234.5659260444545], "unit": "score", "name": "mootools.html", "value": 4883.206684795024}, {"lowerIsBetter": false, "replicates": [288.15426722569254, 289.2941223414869, 324.1458756177473, 332.83690991414204, 336.81138562405073, 6752.729890804368, 6792.2868098849585, 6864.17629884414, 6920.688569014394, 6992.5454845435015, 6838.418734407569, 6850.897236541456, 6853.520253582251, 6871.896921546181, 6875.381215690587, 4833.7099774013495, 4892.535209155125, 4993.251012348141, 5026.447090820006, 5081.79672813087, 5000.52495012975, 5009.924851127236, 5029.899402011957, 5039.874003149932, 5041.647084704072, 5005.974970125162, 5029.371328583927, 5033.345665063555, 5035.320231768701, 5071.7717702703285, 4993.725345106018, 5015.949840501585, 5022.773975171126, 5036.471170527078, 5038.420581633086, 4302.68768025752, 4331.224198078804, 4331.610155086058, 4332.91334173318, 4336.392904993303, 5358.062339090644, 6337.2395312562785, 6377.68111594423, 6620.702068406933, 6642.867142657168, 5902.763889444417, 5954.017587098124, 5974.790882319098, 5976.940230597682, 5988.071848863433, 7200.495965282433, 7251.456140789462, 7255.52839065459, 7269.345758881673, 7270.491065625409, 4818.060478206751, 4821.831235906727, 4826.806927722887, 4834.709917404967, 4834.8791280218275, 7693.422993275527, 7693.538387696756, 7694.846103077907, 7711.807204819868, 7750.0, 3878.8836334909997, 3947.6775280280854, 4529.728216307032, 4724.385829842098, 4765.642576806753, 4807.855764327076, 4869.756512174377, 4873.537013983666, 4875.536824001714, 4892.877678058006, 5806.274215723035, 5836.591438599257, 5872.853178670482, 5881.235439392852, 5892.263467066617, 5875.823725288248, 7368.926310736824, 7393.963030184922, 7394.704211831467, 7415.258474152542, 1396.615930619088, 1666.45007147641, 1684.1663376628646, 1685.401682402754, 1688.2909178145208, 1034.5499707627055, 1071.12703146935, 1072.51736718477, 1074.4949873559415, 1095.9780804384027, 6737.59574425536, 6788.626625535544, 6802.693878775467, 6806.149231346082, 6825.283345248777, 7351.70593176267, 7625.199354067743, 7763.650635721406, 7776.183500732454, 7785.532868027936, 6673.899891501631, 6843.3840954314355, 6864.965675171592, 6878.071460352889, 6928.030075789394, 4019.8995025124023, 4048.0284731664187, 4058.228936502055, 4068.3287257602756, 4072.5927407259037, 6774.322567743285, 7645.847083058419, 7775.833624956302, 8016.759497215093, 8070.717524886601, 7591.3926885849, 7864.4888082274465, 7875.527468351917, 7894.131645518988, 7931.405144614062, 6364.427201551883, 7963.641636126388, 7996.0, 8056.999999999883, 8067.03195616518, 6627.0, 7255.984162217399, 7615.771526854203, 7661.846763064819, 7699.538027718355, 7548.207438218908, 7549.3583045439555, 7555.622218889143, 7558.58427786477, 7559.055118110236, 7222.96388518075, 7760.3791696663, 8008.919910801051, 8047.195280471906, 8074.232947869943, 4716.740579268173, 4735.408073990751, 4765.547273009059, 4805.37530121082, 4810.759462026955, 7620.199879012624, 7622.237776222333, 7622.809429764078, 7627.199144089791, 7654.196309387434, 6373.968130159319, 7025.789226323219, 7335.7432489862595, 7378.778636640909, 7381.298776616213, 7173.210946795744, 7268.345848873627, 7360.852782944418, 7387.889181662387, 7405.518641288299, 7119.6084215368655, 7136.750213742494, 7152.856942861218, 7175.31834475724, 7199.82000449972, 6274.341194174546, 6991.405730512964, 7327.230640782641, 7333.926660733325, 7375.11498620169, 6308.0, 6918.411934985381, 7172.462065345016, 7186.173590037003, 7193.676284567103], "unit": "score", "name": "prototype.html", "value": 5302.297339678619}, {"lowerIsBetter": false, "replicates": [657.2310396835702, 665.4111111666174, 665.8102440804372, 669.8593295407964, 732.198242923998, 11847.0, 14178.0, 14222.786658200122, 14380.712385752291, 14577.125372477658, 13615.591532254024, 13647.317634118304, 13647.727045459085, 13668.794968075463, 13672.726545469084, 742.610129681916, 905.2893478619269, 908.954552272387, 940.0834186668012, 942.3733217410414, 907.4782000349792, 928.0580211085753, 932.0399988012358, 933.8365785987459, 935.4854829843592, 966.3090890013674, 977.9315447918649, 982.1259079419323, 983.0562659846556, 985.1281615770059, 947.346331031586, 947.3699989507004, 967.5839389062701, 973.0707174648229, 975.1418751498707, 706.261956255714, 707.6567864585672, 707.8230442389403, 707.961062141582, 718.2960698515432, 14646.926765366212, 14680.706385872223, 14721.926390368088, 14841.406343746237, 14856.108633481917, 12461.501539938392, 12475.001999839991, 12482.875171248263, 12650.74698506034, 12719.618411447671, 8957.328200384933, 9710.077542633438, 9732.318737688365, 9851.359661622044, 9900.554475048568, 3548.4677298405186, 3553.378158822196, 3554.1470047188745, 3625.1299688074937, 3654.28741395428, 55027.0, 80860.59569702172, 81249.0, 81677.59161204156, 82166.0, 9279.443233406017, 9325.487098209527, 9332.813343733224, 9375.812483750287, 9652.662156824617, 20598.382048538268, 20645.380638580868, 20651.793482064986, 20656.967151642657, 20664.966751662356, 5837.445442682938, 7029.332213439715, 7207.108380868735, 7253.673584688701, 7334.413246940232, 4036.535798383165, 4091.263572556909, 4102.979485102615, 4112.485939257593, 4118.279301122351, 3491.5984661763714, 3545.3795585772386, 3577.177249232691, 3584.318979393959, 3586.049696830342, 651.2282944710438, 651.7881688451272, 658.315352033889, 671.2716702377975, 672.2034389248756, 474.66061765837594, 537.6156048425395, 555.6999220420928, 573.6902072880598, 579.4900487570994, 7586.772396828104, 7894.526328420313, 7928.841423171504, 8068.636911339004, 8123.7156699515235, 508.47626944247486, 525.7607788456244, 528.7726277700625, 548.7311217503394, 561.1414535760293, 3578.624244454347, 3721.962780372216, 3729.272791805626, 3762.5847929280512, 3801.3537698590753, 77599.0, 78640.60679696564, 79052.0, 80984.19015809885, 82083.0, 68357.65821170862, 68360.0, 68444.6577767108, 69514.9572756409, 69783.0, 59621.701891490266, 60087.39912600818, 60165.39834601685, 60512.697436512535, 60675.69662151661, 5843.795467158629, 7396.371308438628, 7414.480986330905, 7422.554646721214, 7970.641321140447, 43983.78008109939, 44620.0, 45599.0, 45778.31332530081, 45867.31199032084, 47384.7630761844, 55052.89894202013, 61209.0, 62297.68851155715, 62435.43911402251, 9388.859167112636, 9495.0, 9564.33049686543, 9577.329586929127, 9892.615033895405, 10149.594016239564, 10268.332558383681, 10405.427701476492, 10655.987681170276, 11687.240329378563, 10761.923807619176, 10836.187285953743, 10899.56401743953, 10940.45297735126, 11825.11605690159, 10174.491275436347, 11158.832617510907, 11284.379359135326, 11387.259828111146, 12366.010719142627, 8643.56782160902, 9040.367174297999, 9213.769655758391, 10421.426821524889, 11191.608293709682, 9168.0, 9329.580168892551, 9331.720048398287, 9460.337776355589, 9543.33196676226, 8945.19493245611, 9053.728388148365, 9253.120953509406, 9300.348975571645, 9344.859827102735], "unit": "score", "name": "yui.html", "value": 6557.670599770628}], "name": "dromaeo_css", "value": 7433.305216994179}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 109.0, 116.0, 115.0, 130.0, 185.0, 156.0, 113.0, 120.0, 164.0], "unit": "score", "name": "ai-astar", "value": 132.4}, {"lowerIsBetter": true, "replicates": [149.0, 125.0, 141.0, 172.0, 107.0, 166.0, 175.0, 148.0, 178.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [195.0, 199.0, 196.0, 216.0, 217.0, 272.0, 244.0, 196.0, 245.0, 274.0], "unit": "score", "name": "audio-dft", "value": 225.4}, {"lowerIsBetter": true, "replicates": [66.0, 90.0, 94.0, 147.0, 58.0, 57.0, 62.0, 60.0, 124.0, 77.0], "unit": "score", "name": "audio-fft", "value": 83.5}, {"lowerIsBetter": true, "replicates": [81.0, 89.0, 122.0, 79.0, 82.0, 80.0, 122.0, 82.0, 79.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 92.9}, {"lowerIsBetter": true, "replicates": [90.0, 88.0, 89.0, 87.0, 100.0, 128.0, 91.0, 88.0, 89.0, 101.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.1}, {"lowerIsBetter": true, "replicates": [139.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 97.0, 93.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 99.9}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 115.0, 118.0, 100.0, 92.0, 90.0, 93.0, 92.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 97.3}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 58.0, 57.0, 59.0, 58.0, 56.0, 66.0, 58.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 67.0, 71.0, 66.0, 67.0, 67.0, 67.0, 68.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 85.0, 77.0, 91.0, 109.0, 106.0, 95.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.9}, {"lowerIsBetter": true, "replicates": [124.0, 140.0, 142.0, 107.0, 125.0, 149.0, 141.0, 130.0, 135.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.9}, {"lowerIsBetter": true, "replicates": [133.0, 144.0, 142.0, 144.0, 142.0, 130.0, 142.0, 144.0, 142.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.1}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 66.0, 69.0, 69.0, 68.0, 66.0, 68.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1532.9}]} 05:27:03 INFO - Return code: 0 05:27:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:27:03 ERROR - # TBPL SUCCESS # 05:27:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:27:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:27:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:27:03 INFO - 2016-03-24 05:27:03.884 screenresolution[1689:10711] starting screenresolution argv=screenresolution get 05:27:03 INFO - 2016-03-24 05:27:03.887 screenresolution[1689:10711] Display 0: 1600x1200x32@60 05:27:03 INFO - 2016-03-24 05:27:03.892 screenresolution[1690:10714] starting screenresolution argv=screenresolution list 05:27:03 INFO - Available Modes on Display 0 05:27:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:27:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:27:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:27:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:27:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:27:04 INFO - Intel Iris: 05:27:04 INFO - Chipset Model: Intel Iris 05:27:04 INFO - Type: GPU 05:27:04 INFO - Bus: Built-In 05:27:04 INFO - VRAM (Dynamic, Max): 1536 MB 05:27:04 INFO - Vendor: Intel (0x8086) 05:27:04 INFO - Device ID: 0x0a2e 05:27:04 INFO - Revision ID: 0x0009 05:27:04 INFO - Displays: 05:27:04 INFO - Display: 05:27:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:27:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:27:04 INFO - Display Serial Number: 1600x1200 60 05:27:04 INFO - Main Display: Yes 05:27:04 INFO - Mirror: Off 05:27:04 INFO - Online: Yes 05:27:04 INFO - Rotation: Supported 05:27:04 INFO - Return code: 0 05:27:04 INFO - Running post-action listener: _resource_record_post_action 05:27:04 INFO - Running post-run listener: _resource_record_post_run 05:27:05 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 34147840; Write bytes: 708300288; Read time: 360; Write time: 1963 05:27:05 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 381641216; Write bytes: 375555584; Read time: 29537; Write time: 765 05:27:05 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 33213952; Write bytes: 303630336; Read time: 345; Write time: 1139 05:27:05 INFO - Running post-run listener: _upload_blobber_files 05:27:05 INFO - Blob upload gear active. 05:27:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:27:05 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 05:27:05 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'] 05:27:05 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 05:27:05 INFO - (blobuploader) - INFO - Open directory for files ... 05:27:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:27:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:27:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:06 INFO - (blobuploader) - INFO - Done attempting. 05:27:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:27:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:27:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:07 INFO - (blobuploader) - INFO - Done attempting. 05:27:07 INFO - (blobuploader) - INFO - Iteration through files over. 05:27:07 INFO - Return code: 0 05:27:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:27:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:27:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e739ca67405304a1ac63ad6d6178227cf7dcd39ba463f40e3b9b957ed31b442483e0d0cb07566088cf21a38bd796b6f65edb9ac1e12c985a4eaed3b9f5c577f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cd119c4a59bdc33c7a74edb6c15b2bc92c30cd88206364b235c0f62d8c9dff743e3b2974335268ce0fa34fa7c35e9e641daa9192bc81aa47a313bfa08a0f1b0"} 05:27:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:27:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:27:07 INFO - Contents: 05:27:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e739ca67405304a1ac63ad6d6178227cf7dcd39ba463f40e3b9b957ed31b442483e0d0cb07566088cf21a38bd796b6f65edb9ac1e12c985a4eaed3b9f5c577f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cd119c4a59bdc33c7a74edb6c15b2bc92c30cd88206364b235c0f62d8c9dff743e3b2974335268ce0fa34fa7c35e9e641daa9192bc81aa47a313bfa08a0f1b0"} 05:27:07 INFO - Running post-run listener: copy_logs_to_upload_dir 05:27:07 INFO - Copying logs to upload dir... 05:27:07 INFO - mkdir: /builds/slave/test/build/upload/logs 05:27:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.764256 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-24 05:27:07.998061) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 05:27:08.001249) ========= 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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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/4e739ca67405304a1ac63ad6d6178227cf7dcd39ba463f40e3b9b957ed31b442483e0d0cb07566088cf21a38bd796b6f65edb9ac1e12c985a4eaed3b9f5c577f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cd119c4a59bdc33c7a74edb6c15b2bc92c30cd88206364b235c0f62d8c9dff743e3b2974335268ce0fa34fa7c35e9e641daa9192bc81aa47a313bfa08a0f1b0"} build_url:https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011106 build_url: 'https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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/4e739ca67405304a1ac63ad6d6178227cf7dcd39ba463f40e3b9b957ed31b442483e0d0cb07566088cf21a38bd796b6f65edb9ac1e12c985a4eaed3b9f5c577f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cd119c4a59bdc33c7a74edb6c15b2bc92c30cd88206364b235c0f62d8c9dff743e3b2974335268ce0fa34fa7c35e9e641daa9192bc81aa47a313bfa08a0f1b0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 05:27:08.029047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:27:08.029353) ========= 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.xiBSwLlaRu/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.YTUmXbmSzt/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.005327 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 05:27:08.079479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 05:27:08.079771) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 05:27:08.080158) ========= ========= Total master_lag: 11.71 =========