builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0094 starttime: 1455023581.74 results: success (0) buildid: 20160209030347 builduid: 0bb195ecac6b4153b86503f213989972 revision: d1a54ae63da7ebc4bc1eeb5b613e8ec29bfcb80a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:01.743832) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:01.744519) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:01.744800) ========= 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.BAPRE82BYI/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.f31K0S4X6S/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.005489 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:01.830703) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:01.830999) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:01.962731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:01.962995) ========= 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.BAPRE82BYI/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.f31K0S4X6S/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.005949 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:02.032666) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:02.032942) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:02.033263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:02.033534) ========= 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.BAPRE82BYI/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.f31K0S4X6S/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-09 05:13:02-- 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% 15.7M=0.001s 2016-02-09 05:13:02 (15.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.542789 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:02.600664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:02.600953) ========= 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.BAPRE82BYI/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.f31K0S4X6S/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.025845 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:02.653661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:02.653976) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d1a54ae63da7ebc4bc1eeb5b613e8ec29bfcb80a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d1a54ae63da7ebc4bc1eeb5b613e8ec29bfcb80a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BAPRE82BYI/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.f31K0S4X6S/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-09 05:13:02,722 truncating revision to first 12 chars 2016-02-09 05:13:02,722 Setting DEBUG logging. 2016-02-09 05:13:02,722 attempt 1/10 2016-02-09 05:13:02,722 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d1a54ae63da7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 05:13:03,439 unpacking tar archive at: mozilla-central-d1a54ae63da7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.965203 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:03.634580) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:03.634928) ========= echo d1a54ae63da7ebc4bc1eeb5b613e8ec29bfcb80a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd1a54ae63da7ebc4bc1eeb5b613e8ec29bfcb80a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BAPRE82BYI/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.f31K0S4X6S/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 d1a54ae63da7ebc4bc1eeb5b613e8ec29bfcb80a program finished with exit code 0 elapsedTime=0.005827 script_repo_revision: 'd1a54ae63da7ebc4bc1eeb5b613e8ec29bfcb80a' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:03.685351) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:03.685654) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 05:13:03.700922) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-02-09 05:13:03.701215) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BAPRE82BYI/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.f31K0S4X6S/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:13:03 INFO - MultiFileLogger online at 20160209 05:13:03 in /builds/slave/test 05:13:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:13:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:13:03 INFO - {'append_to_log': False, 05:13:03 INFO - 'base_work_dir': '/builds/slave/test', 05:13:03 INFO - 'blob_upload_branch': 'Firefox', 05:13:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:13:03 INFO - 'branch': 'Firefox', 05:13:03 INFO - 'buildbot_json_path': 'buildprops.json', 05:13:03 INFO - 'config_files': ('talos/mac_config.py',), 05:13:03 INFO - 'default_actions': ('clobber', 05:13:03 INFO - 'read-buildbot-config', 05:13:03 INFO - 'download-and-extract', 05:13:03 INFO - 'populate-webroot', 05:13:03 INFO - 'create-virtualenv', 05:13:03 INFO - 'install', 05:13:03 INFO - 'run-tests'), 05:13:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:13:03 INFO - 'download_minidump_stackwalk': True, 05:13:03 INFO - 'download_symbols': 'ondemand', 05:13:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:13:03 INFO - 'tooltool.py': '/tools/tooltool.py', 05:13:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:13:03 INFO - '/tools/misc-python/virtualenv.py')}, 05:13:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:13:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:13:03 INFO - 'installer_path': 'installer.exe', 05:13:03 INFO - 'log_level': 'info', 05:13:03 INFO - 'log_name': 'talos', 05:13:03 INFO - 'log_to_console': True, 05:13:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:13:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:13:03 INFO - 'opt_config_files': (), 05:13:03 INFO - 'pip_index': False, 05:13:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:13:03 INFO - 'cmd': ('bash', 05:13:03 INFO - '-c', 05:13:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:13:03 INFO - 'enabled': True, 05:13:03 INFO - 'halt_on_failure': False, 05:13:03 INFO - 'name': 'check_screen_resolution'},), 05:13:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:13:03 INFO - 'cmd': ('bash', 05:13:03 INFO - '-c', 05:13:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:13:03 INFO - 'enabled': True, 05:13:03 INFO - 'halt_on_failure': False, 05:13:03 INFO - 'name': 'check_screen_resolution'},), 05:13:03 INFO - 'run_cmd_checks_enabled': True, 05:13:03 INFO - 'sps_profile': False, 05:13:03 INFO - 'sps_profile_interval': 0, 05:13:03 INFO - 'suite': 'dromaeojs-e10s', 05:13:03 INFO - 'system_bits': '32', 05:13:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:13:03 INFO - 'title': 't-yosemite-r7-0094', 05:13:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:13:03 INFO - 'use_talos_json': True, 05:13:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:13:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:13:03 INFO - 'work_dir': 'build'} 05:13:03 INFO - ##### 05:13:03 INFO - ##### Running clobber step. 05:13:03 INFO - ##### 05:13:03 INFO - Running pre-action listener: _resource_record_pre_action 05:13:03 INFO - Running main action method: clobber 05:13:03 INFO - rmtree: /builds/slave/test/build 05:13:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:13:05 INFO - Running post-action listener: _resource_record_post_action 05:13:05 INFO - ##### 05:13:05 INFO - ##### Running read-buildbot-config step. 05:13:05 INFO - ##### 05:13:05 INFO - Running pre-action listener: _resource_record_pre_action 05:13:05 INFO - Running main action method: read_buildbot_config 05:13:05 INFO - Using buildbot properties: 05:13:05 INFO - { 05:13:05 INFO - "project": "", 05:13:05 INFO - "product": "firefox", 05:13:05 INFO - "script_repo_revision": "production", 05:13:05 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:13:05 INFO - "repository": "", 05:13:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:13:05 INFO - "buildid": "20160209030347", 05:13:05 INFO - "stage_platform": "macosx64", 05:13:05 INFO - "basedir": "/builds/slave/test", 05:13:05 INFO - "nightly_build": "True", 05:13:05 INFO - "buildnumber": 103, 05:13:05 INFO - "slavename": "t-yosemite-r7-0094", 05:13:05 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:13:05 INFO - "platform": "yosemite_r7", 05:13:05 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:13:05 INFO - "branch": "mozilla-central", 05:13:05 INFO - "repo_path": "mozilla-central", 05:13:05 INFO - "revision": "d1a54ae63da7ebc4bc1eeb5b613e8ec29bfcb80a", 05:13:05 INFO - "pgo_build": "False", 05:13:05 INFO - "builduid": "0bb195ecac6b4153b86503f213989972", 05:13:05 INFO - "slavebuilddir": "test" 05:13:05 INFO - } 05:13:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 05:13:05 INFO - Running post-action listener: _resource_record_post_action 05:13:05 INFO - ##### 05:13:05 INFO - ##### Running download-and-extract step. 05:13:05 INFO - ##### 05:13:05 INFO - Running pre-action listener: _resource_record_pre_action 05:13:05 INFO - Running main action method: download_and_extract 05:13:05 INFO - mkdir: /builds/slave/test/build/tests 05:13: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:13:05 INFO - https://queue.taskcluster.net/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:13:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/test_packages.json 05:13:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/test_packages.json 05:13:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:13:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:13:22 INFO - Downloaded 1277 bytes. 05:13:22 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:13:22 INFO - Using the following test package requirements: 05:13:22 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:13:22 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:13:22 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 05:13:22 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:13:22 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 05:13:22 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:13:22 INFO - u'jsshell-mac.zip'], 05:13:22 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:13:22 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 05:13:22 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:13:22 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:13:22 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 05:13:22 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:13:22 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 05:13:22 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:13:22 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 05:13:22 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:13:22 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:13:22 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 05:13:22 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:13:22 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:13:22 INFO - https://queue.taskcluster.net/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:13:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:13:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:13:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:13:24 INFO - Downloaded 17754864 bytes. 05:13:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:13:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:13:27 INFO - Return code: 0 05:13:27 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:27 INFO - https://queue.taskcluster.net/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:13:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:13:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:13:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:13:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:13:42 INFO - Downloaded 17754864 bytes. 05:13:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:13:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:13:45 INFO - Return code: 0 05:13:45 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:13:45 INFO - https://queue.taskcluster.net/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:13:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:13:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:13:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:13:47 INFO - Downloaded 10706547 bytes. 05:13:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:13:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:13:47 INFO - Return code: 0 05:13: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:13:47 INFO - https://queue.taskcluster.net/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:13:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:13:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:13:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 05:13:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 05:13:52 INFO - Downloaded 111964397 bytes. 05:13:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:13:52 INFO - mkdir: /builds/slave/test/properties 05:13:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:13:52 INFO - Writing to file /builds/slave/test/properties/build_url 05:13:52 INFO - Contents: 05:13:52 INFO - build_url:https://queue.taskcluster.net/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:13:53 INFO - Running post-action listener: _resource_record_post_action 05:13:53 INFO - Running post-action listener: set_extra_try_arguments 05:13:53 INFO - ##### 05:13:53 INFO - ##### Running populate-webroot step. 05:13:53 INFO - ##### 05:13:53 INFO - Running pre-action listener: _resource_record_pre_action 05:13:53 INFO - Running main action method: populate_webroot 05:13:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:13:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:13:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:13:53 INFO - '--tppagecycles', 05:13:53 INFO - '7'], 05:13:53 INFO - 'tests': ['tsvgm']}}, 05:13:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:13:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:13:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:13:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:13:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:13:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:13:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:53 INFO - 'talos_options': ['--e10s'], 05:13:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:53 INFO - 'tests': ['damp', 'tps']}, 05:13:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:53 INFO - 'talos_options': ['--e10s'], 05:13:53 INFO - 'tests': ['damp', 'tps']}, 05:13:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:13:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:13:53 INFO - 'other': {'tests': ['a11yr', 05:13:53 INFO - 'ts_paint', 05:13:53 INFO - 'tpaint', 05:13:53 INFO - 'sessionrestore', 05:13:53 INFO - 'sessionrestore_no_auto_restore']}, 05:13:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:13:53 INFO - 'tests': ['a11yr', 05:13:53 INFO - 'ts_paint', 05:13:53 INFO - 'tpaint', 05:13:53 INFO - 'sessionrestore', 05:13:53 INFO - 'sessionrestore_no_auto_restore']}, 05:13:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:13:53 INFO - 'tests': ['a11yr', 05:13:53 INFO - 'ts_paint', 05:13:53 INFO - 'tpaint', 05:13:53 INFO - 'sessionrestore', 05:13:53 INFO - 'sessionrestore_no_auto_restore']}, 05:13:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:13:53 INFO - 'tests': ['a11yr', 05:13:53 INFO - 'ts_paint', 05:13:53 INFO - 'tpaint', 05:13:53 INFO - 'sessionrestore', 05:13:53 INFO - 'sessionrestore_no_auto_restore']}, 05:13:53 INFO - 'other_l64': {'tests': ['a11yr', 05:13:53 INFO - 'ts_paint', 05:13:53 INFO - 'tpaint', 05:13:53 INFO - 'sessionrestore', 05:13:53 INFO - 'sessionrestore_no_auto_restore']}, 05:13:53 INFO - 'other_nol64': {'tests': ['a11yr', 05:13:53 INFO - 'ts_paint', 05:13:53 INFO - 'tpaint', 05:13:53 INFO - 'sessionrestore', 05:13:53 INFO - 'sessionrestore_no_auto_restore']}, 05:13:53 INFO - 'svgr': {'tests': ['tsvgx', 05:13:53 INFO - 'tsvgr_opacity', 05:13:53 INFO - 'tart', 05:13:53 INFO - 'tscrollx', 05:13:53 INFO - 'cart']}, 05:13:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:13:53 INFO - 'tests': ['tsvgx', 05:13:53 INFO - 'tsvgr_opacity', 05:13:53 INFO - 'tart', 05:13:53 INFO - 'tscrollx', 05:13:53 INFO - 'cart']}, 05:13:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:53 INFO - 'tests': ['tp5o']}, 05:13:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:53 INFO - 'talos_options': ['--e10s'], 05:13:53 INFO - 'tests': ['tp5o']}, 05:13:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:53 INFO - 'talos_options': ['--xperf_path', 05:13:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:53 INFO - 'tests': ['tp5n']}, 05:13:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:53 INFO - 'talos_options': ['--e10s', 05:13:53 INFO - '--xperf_path', 05:13:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:53 INFO - 'tests': ['tp5n']}}, 05:13:53 INFO - 'talos.zip': {'path': '', 05:13:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:13:53 INFO - Running post-action listener: _resource_record_post_action 05:13:53 INFO - ##### 05:13:53 INFO - ##### Running create-virtualenv step. 05:13:53 INFO - ##### 05:13:53 INFO - Running pre-action listener: _resource_record_pre_action 05:13:53 INFO - Running main action method: create_virtualenv 05:13:53 INFO - Creating virtualenv /builds/slave/test/build/venv 05:13:53 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:13:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:13:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:13:53 INFO - Using real prefix '/tools/python27' 05:13:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:13:54 INFO - Installing distribute.............................................................................................................................................................................................done. 05:13:57 INFO - Installing pip.................done. 05:13:57 INFO - Return code: 0 05:13:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:13:57 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:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:57 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:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:57 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 0x10edb7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edbe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff24849b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5bd30>, '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 0x10ea7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec52b20>, '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.BAPRE82BYI/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.f31K0S4X6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:13:57 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:13:57 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:13:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BAPRE82BYI/Render', 05:13:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:57 INFO - 'HOME': '/Users/cltbld', 05:13:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:57 INFO - 'LOGNAME': 'cltbld', 05:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:57 INFO - 'MOZ_NO_REMOTE': '1', 05:13:57 INFO - 'NO_EM_RESTART': '1', 05:13:57 INFO - 'PAGER': '/bin/cat', 05:13:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:57 INFO - 'PWD': '/builds/slave/test', 05:13:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:57 INFO - 'SHELL': '/bin/bash', 05:13:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f31K0S4X6S/Listeners', 05:13:57 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 05:13:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:57 INFO - 'USER': 'cltbld', 05:13:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:57 INFO - 'XPC_FLAGS': '0x0', 05:13:57 INFO - 'XPC_SERVICE_NAME': '0', 05:13:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:57 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:13:57 INFO - Cleaning up... 05:13:57 INFO - Return code: 0 05:13:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:13:57 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:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:57 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:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:57 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 0x10edb7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edbe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff24849b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5bd30>, '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 0x10ea7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec52b20>, '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.BAPRE82BYI/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.f31K0S4X6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:13:57 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:13:57 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:13:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BAPRE82BYI/Render', 05:13:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:57 INFO - 'HOME': '/Users/cltbld', 05:13:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:57 INFO - 'LOGNAME': 'cltbld', 05:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:57 INFO - 'MOZ_NO_REMOTE': '1', 05:13:57 INFO - 'NO_EM_RESTART': '1', 05:13:57 INFO - 'PAGER': '/bin/cat', 05:13:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:57 INFO - 'PWD': '/builds/slave/test', 05:13:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:57 INFO - 'SHELL': '/bin/bash', 05:13:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f31K0S4X6S/Listeners', 05:13:57 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 05:13:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:57 INFO - 'USER': 'cltbld', 05:13:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:57 INFO - 'XPC_FLAGS': '0x0', 05:13:57 INFO - 'XPC_SERVICE_NAME': '0', 05:13:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:57 INFO - Downloading/unpacking psutil>=0.7.1 05:13:57 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:13:57 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:13:57 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:13:57 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:13:57 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:13:57 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:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:14:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:00 INFO - Installing collected packages: psutil 05:14:00 INFO - Running setup.py install for psutil 05:14:00 INFO - building 'psutil._psutil_osx' extension 05:14:00 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:14:01 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:14:01 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:14:01 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:14:01 INFO - building 'psutil._psutil_posix' extension 05:14:01 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:14:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:14:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:14:01 INFO - ^ 05:14:01 INFO - 1 warning generated. 05:14:01 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:14:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:01 INFO - Successfully installed psutil 05:14:01 INFO - Cleaning up... 05:14:01 INFO - Return code: 0 05:14:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:01 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 0x10edb7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edbe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff24849b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5bd30>, '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 0x10ea7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec52b20>, '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.BAPRE82BYI/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.f31K0S4X6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:14:01 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:14:01 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:14:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BAPRE82BYI/Render', 05:14:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:01 INFO - 'HOME': '/Users/cltbld', 05:14:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:01 INFO - 'LOGNAME': 'cltbld', 05:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:01 INFO - 'MOZ_NO_REMOTE': '1', 05:14:01 INFO - 'NO_EM_RESTART': '1', 05:14:01 INFO - 'PAGER': '/bin/cat', 05:14:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:01 INFO - 'PWD': '/builds/slave/test', 05:14:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:01 INFO - 'SHELL': '/bin/bash', 05:14:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f31K0S4X6S/Listeners', 05:14:01 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 05:14:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:01 INFO - 'USER': 'cltbld', 05:14:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:01 INFO - 'XPC_FLAGS': '0x0', 05:14:01 INFO - 'XPC_SERVICE_NAME': '0', 05:14:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:14:04 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:14:04 INFO - Installing collected packages: mozsystemmonitor 05:14:04 INFO - Running setup.py install for mozsystemmonitor 05:14:04 INFO - Successfully installed mozsystemmonitor 05:14:04 INFO - Cleaning up... 05:14:04 INFO - Return code: 0 05:14:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:04 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 0x10edb7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edbe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff24849b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5bd30>, '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 0x10ea7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec52b20>, '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.BAPRE82BYI/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.f31K0S4X6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:14:04 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:14:04 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:14:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BAPRE82BYI/Render', 05:14:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:04 INFO - 'HOME': '/Users/cltbld', 05:14:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:04 INFO - 'LOGNAME': 'cltbld', 05:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:04 INFO - 'MOZ_NO_REMOTE': '1', 05:14:04 INFO - 'NO_EM_RESTART': '1', 05:14:04 INFO - 'PAGER': '/bin/cat', 05:14:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:04 INFO - 'PWD': '/builds/slave/test', 05:14:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:04 INFO - 'SHELL': '/bin/bash', 05:14:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f31K0S4X6S/Listeners', 05:14:04 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 05:14:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:04 INFO - 'USER': 'cltbld', 05:14:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:04 INFO - 'XPC_FLAGS': '0x0', 05:14:04 INFO - 'XPC_SERVICE_NAME': '0', 05:14:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:04 INFO - Downloading/unpacking blobuploader==1.2.4 05:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:07 INFO - Downloading blobuploader-1.2.4.tar.gz 05:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:14:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:14:07 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:14:07 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:14:07 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:14:07 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:14:07 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:14:07 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:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:14:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:08 INFO - Downloading docopt-0.6.1.tar.gz 05:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:14:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:14:09 INFO - Running setup.py install for blobuploader 05:14:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:14:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:14:09 INFO - Running setup.py install for requests 05:14:09 INFO - Running setup.py install for docopt 05:14:09 INFO - Successfully installed blobuploader requests docopt 05:14:09 INFO - Cleaning up... 05:14:09 INFO - Return code: 0 05:14:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:10 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 0x10edb7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edbe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff24849b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5bd30>, '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 0x10ea7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec52b20>, '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.BAPRE82BYI/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.f31K0S4X6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:14:10 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:14:10 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:14:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BAPRE82BYI/Render', 05:14:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:10 INFO - 'HOME': '/Users/cltbld', 05:14:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:10 INFO - 'LOGNAME': 'cltbld', 05:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:10 INFO - 'MOZ_NO_REMOTE': '1', 05:14:10 INFO - 'NO_EM_RESTART': '1', 05:14:10 INFO - 'PAGER': '/bin/cat', 05:14:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:10 INFO - 'PWD': '/builds/slave/test', 05:14:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:10 INFO - 'SHELL': '/bin/bash', 05:14:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f31K0S4X6S/Listeners', 05:14:10 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 05:14:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:10 INFO - 'USER': 'cltbld', 05:14:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:10 INFO - 'XPC_FLAGS': '0x0', 05:14:10 INFO - 'XPC_SERVICE_NAME': '0', 05:14:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-_wPP7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-HXblB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-v2HswL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-0GzUKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-wktLC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-yJKbx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-0CMtX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Jld2JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-texew5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-dofjbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-cy8QqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-cXQ_8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-MgzIA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:11 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-6X_VWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:12 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-IGCj8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:12 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-A0oQZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:12 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-TqLJX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:14:12 INFO - Running setup.py install for manifestparser 05:14:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:14:12 INFO - Running setup.py install for mozcrash 05:14:12 INFO - Running setup.py install for mozdebug 05:14:12 INFO - Running setup.py install for mozdevice 05:14:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:14:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:14:12 INFO - Running setup.py install for mozfile 05:14:13 INFO - Running setup.py install for mozhttpd 05:14:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:14:13 INFO - Running setup.py install for mozinfo 05:14:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:14:13 INFO - Running setup.py install for mozInstall 05:14:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:14:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:14:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:14:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:14:13 INFO - Running setup.py install for mozleak 05:14:13 INFO - Running setup.py install for mozlog 05:14:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:14:13 INFO - Running setup.py install for moznetwork 05:14:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:14:13 INFO - Running setup.py install for mozprocess 05:14:14 INFO - Running setup.py install for mozprofile 05:14:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:14:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:14:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:14:14 INFO - Running setup.py install for mozrunner 05:14:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:14:14 INFO - Running setup.py install for mozscreenshot 05:14:14 INFO - Running setup.py install for moztest 05:14:14 INFO - Running setup.py install for mozversion 05:14:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:14:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:14:14 INFO - Cleaning up... 05:14:14 INFO - Return code: 0 05:14:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:14 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:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:14 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:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:14 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 0x10edb7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edbe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff24849b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5bd30>, '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 0x10ea7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec52b20>, '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.BAPRE82BYI/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.f31K0S4X6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:14:14 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:14:14 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:14:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BAPRE82BYI/Render', 05:14:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:14 INFO - 'HOME': '/Users/cltbld', 05:14:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:14 INFO - 'LOGNAME': 'cltbld', 05:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:14 INFO - 'MOZ_NO_REMOTE': '1', 05:14:14 INFO - 'NO_EM_RESTART': '1', 05:14:14 INFO - 'PAGER': '/bin/cat', 05:14:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:14 INFO - 'PWD': '/builds/slave/test', 05:14:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:14 INFO - 'SHELL': '/bin/bash', 05:14:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f31K0S4X6S/Listeners', 05:14:14 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 05:14:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:14 INFO - 'USER': 'cltbld', 05:14:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:14 INFO - 'XPC_FLAGS': '0x0', 05:14:14 INFO - 'XPC_SERVICE_NAME': '0', 05:14:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-XDwN8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:15 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:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-DjRCTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-7YcMET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:15 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:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-cZobak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:15 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:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-SOq511-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:15 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:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-L3EBlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:15 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:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-43Bk28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:15 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:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-0l7M7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:16 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:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:16 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-kswtr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:16 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:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:16 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-_VI0DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:16 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:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:16 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Hsr5zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:16 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:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:16 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-64HmII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:16 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:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:16 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-l3ZbEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:16 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:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:16 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-9MXqhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:16 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:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:16 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-dL0gQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:16 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:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:16 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-St4qXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:16 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:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:16 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-ee5bgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:16 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:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:16 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:14:16 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:14:16 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:14:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:19 INFO - Downloading blessings-1.6.tar.gz 05:14:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:14:19 INFO - Installing collected packages: blessings 05:14:19 INFO - Running setup.py install for blessings 05:14:19 INFO - Successfully installed blessings 05:14:19 INFO - Cleaning up... 05:14:19 INFO - Return code: 0 05:14:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:14:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:19 INFO - Reading from file tmpfile_stdout 05:14:19 INFO - Current package versions: 05:14:19 INFO - blessings == 1.6 05:14:19 INFO - blobuploader == 1.2.4 05:14:19 INFO - docopt == 0.6.1 05:14:19 INFO - manifestparser == 1.1 05:14:19 INFO - mozInstall == 1.12 05:14:19 INFO - mozcrash == 0.16 05:14:19 INFO - mozdebug == 0.1 05:14:19 INFO - mozdevice == 0.48 05:14:19 INFO - mozfile == 1.2 05:14:19 INFO - mozhttpd == 0.7 05:14:19 INFO - mozinfo == 0.9 05:14:19 INFO - mozleak == 0.1 05:14:19 INFO - mozlog == 3.1 05:14:19 INFO - moznetwork == 0.27 05:14:19 INFO - mozprocess == 0.22 05:14:19 INFO - mozprofile == 0.28 05:14:19 INFO - mozrunner == 6.11 05:14:19 INFO - mozscreenshot == 0.1 05:14:19 INFO - mozsystemmonitor == 0.0 05:14:19 INFO - moztest == 0.7 05:14:19 INFO - mozversion == 1.4 05:14:19 INFO - psutil == 3.1.1 05:14:19 INFO - requests == 1.2.3 05:14:19 INFO - wsgiref == 0.1.2 05:14:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:19 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 0x10edb7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edbe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff24849b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5bd30>, '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 0x10ea7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec52b20>, '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.BAPRE82BYI/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.f31K0S4X6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:14:19 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:14:19 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:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BAPRE82BYI/Render', 05:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:19 INFO - 'HOME': '/Users/cltbld', 05:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:19 INFO - 'LOGNAME': 'cltbld', 05:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:19 INFO - 'MOZ_NO_REMOTE': '1', 05:14:19 INFO - 'NO_EM_RESTART': '1', 05:14:19 INFO - 'PAGER': '/bin/cat', 05:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:19 INFO - 'PWD': '/builds/slave/test', 05:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:19 INFO - 'SHELL': '/bin/bash', 05:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f31K0S4X6S/Listeners', 05:14:19 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 05:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:19 INFO - 'USER': 'cltbld', 05:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:19 INFO - 'XPC_FLAGS': '0x0', 05:14:19 INFO - 'XPC_SERVICE_NAME': '0', 05:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:20 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:14:20 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:14:20 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:14:20 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:14:20 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:14:20 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:14:20 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:14:20 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:14:20 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:14:20 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:14:20 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:14:20 INFO - Cleaning up... 05:14:20 INFO - Return code: 0 05:14:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:14:20 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:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:20 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:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:20 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 0x10edb7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edbe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff24849b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5bd30>, '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 0x10ea7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec52b20>, '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.BAPRE82BYI/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.f31K0S4X6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:14:20 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:14:20 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:14:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BAPRE82BYI/Render', 05:14:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:20 INFO - 'HOME': '/Users/cltbld', 05:14:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:20 INFO - 'LOGNAME': 'cltbld', 05:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:20 INFO - 'MOZ_NO_REMOTE': '1', 05:14:20 INFO - 'NO_EM_RESTART': '1', 05:14:20 INFO - 'PAGER': '/bin/cat', 05:14:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:20 INFO - 'PWD': '/builds/slave/test', 05:14:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:20 INFO - 'SHELL': '/bin/bash', 05:14:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f31K0S4X6S/Listeners', 05:14:20 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 05:14:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:20 INFO - 'USER': 'cltbld', 05:14:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:20 INFO - 'XPC_FLAGS': '0x0', 05:14:20 INFO - 'XPC_SERVICE_NAME': '0', 05:14:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:20 INFO - Downloading/unpacking jsonschema 05:14:20 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:14:20 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:14:20 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:14:20 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:14:20 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:14:20 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:14:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:14:22 INFO - Downloading/unpacking functools32 (from jsonschema) 05:14:22 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:14:22 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:14:22 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:14:22 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:14:22 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:14:22 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:14:23 INFO - Downloading functools32-3.2.3-2.tar.gz 05:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:14:23 INFO - warning: no files found matching '*.txt' 05:14:23 INFO - no previously-included directories found matching 'build' 05:14:23 INFO - no previously-included directories found matching 'dist' 05:14:23 INFO - no previously-included directories found matching '.git*' 05:14:23 INFO - Installing collected packages: jsonschema, functools32 05:14:23 INFO - Running setup.py install for functools32 05:14:23 INFO - warning: no files found matching '*.txt' 05:14:23 INFO - no previously-included directories found matching 'build' 05:14:23 INFO - no previously-included directories found matching 'dist' 05:14:23 INFO - no previously-included directories found matching '.git*' 05:14:23 INFO - Successfully installed jsonschema functools32 05:14:23 INFO - Cleaning up... 05:14:23 INFO - Return code: 0 05:14:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10edb7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edbe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff24849b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec5bd30>, '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 0x10ea7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec52b20>, '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.BAPRE82BYI/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.f31K0S4X6S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:14:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BAPRE82BYI/Render', 05:14:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:23 INFO - 'HOME': '/Users/cltbld', 05:14:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:23 INFO - 'LOGNAME': 'cltbld', 05:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:23 INFO - 'MOZ_NO_REMOTE': '1', 05:14:23 INFO - 'NO_EM_RESTART': '1', 05:14:23 INFO - 'PAGER': '/bin/cat', 05:14:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:23 INFO - 'PWD': '/builds/slave/test', 05:14:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:23 INFO - 'SHELL': '/bin/bash', 05:14:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f31K0S4X6S/Listeners', 05:14:23 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 05:14:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:23 INFO - 'USER': 'cltbld', 05:14:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:23 INFO - 'XPC_FLAGS': '0x0', 05:14:23 INFO - 'XPC_SERVICE_NAME': '0', 05:14:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:23 INFO - Downloading/unpacking flake8 05:14:23 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:14:23 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:14:23 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:14:23 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:14:23 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:14:23 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:14:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:14:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:14:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:14:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:14:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:14:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:14:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:14:27 INFO - no previously-included directories found matching 'docs/_build' 05:14:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:14:27 INFO - Running setup.py install for pep8 05:14:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:14:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:14:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:14:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:14:27 INFO - no previously-included directories found matching 'docs/_build' 05:14:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:14:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:14:27 INFO - Cleaning up... 05:14:27 INFO - Return code: 0 05:14:27 INFO - Running post-action listener: _resource_record_post_action 05:14:27 INFO - Running post-action listener: _start_resource_monitoring 05:14:27 INFO - Starting resource monitoring. 05:14:27 INFO - ##### 05:14:27 INFO - ##### Running install step. 05:14:27 INFO - ##### 05:14:27 INFO - Running pre-action listener: _resource_record_pre_action 05:14:27 INFO - Running main action method: install 05:14:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:27 INFO - Reading from file tmpfile_stdout 05:14:27 INFO - Detecting whether we're running mozinstall >=1.0... 05:14:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:14:28 INFO - Reading from file tmpfile_stdout 05:14:28 INFO - Output received: 05:14:28 INFO - Usage: mozinstall [options] installer 05:14:28 INFO - Options: 05:14:28 INFO - -h, --help show this help message and exit 05:14:28 INFO - -d DEST, --destination=DEST 05:14:28 INFO - Directory to install application into. [default: 05:14:28 INFO - "/builds/slave/test"] 05:14:28 INFO - --app=APP Application being installed. [default: firefox] 05:14:28 INFO - mkdir: /builds/slave/test/build/application 05:14:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:15:01 INFO - Reading from file tmpfile_stdout 05:15:01 INFO - Output received: 05:15:01 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:15:01 INFO - Running post-action listener: _resource_record_post_action 05:15:01 INFO - ##### 05:15:01 INFO - ##### Running run-tests step. 05:15:01 INFO - ##### 05:15:01 INFO - Running pre-action listener: _resource_record_pre_action 05:15:01 INFO - Running main action method: run_tests 05:15:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:15:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:15:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:15:01 INFO - 2016-02-09 05:15:01.861 screenresolution[1661:8249] starting screenresolution argv=screenresolution get 05:15:01 INFO - 2016-02-09 05:15:01.864 screenresolution[1661:8249] Display 0: 1600x1200x32@60 05:15:01 INFO - 2016-02-09 05:15:01.870 screenresolution[1662:8251] starting screenresolution argv=screenresolution list 05:15:01 INFO - Available Modes on Display 0 05:15:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:15:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:15:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:15:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:15:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:15:02 INFO - Intel Iris: 05:15:02 INFO - Chipset Model: Intel Iris 05:15:02 INFO - Type: GPU 05:15:02 INFO - Bus: Built-In 05:15:02 INFO - VRAM (Dynamic, Max): 1536 MB 05:15:02 INFO - Vendor: Intel (0x8086) 05:15:02 INFO - Device ID: 0x0a2e 05:15:02 INFO - Revision ID: 0x0009 05:15:02 INFO - Displays: 05:15:02 INFO - Display: 05:15:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:15:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:15:02 INFO - Display Serial Number: 1600x1200 60 05:15:02 INFO - Main Display: Yes 05:15:02 INFO - Mirror: Off 05:15:02 INFO - Online: Yes 05:15:02 INFO - Rotation: Supported 05:15:02 INFO - Return code: 0 05:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:15:02 INFO - Python 2.7.3 05:15:02 INFO - Return code: 0 05:15:02 INFO - grabbing minidump binary from tooltool 05:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:02 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 0x10ec5bd30>, '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 0x10ea7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec52b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:15:02 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:15:02 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:15:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:15:02 INFO - Return code: 0 05:15:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:15:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:15:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:15:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:15:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:15:03 INFO - Return code: 0 05:15:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--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:15:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0094 --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:15:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BAPRE82BYI/Render', 05:15:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:03 INFO - 'HOME': '/Users/cltbld', 05:15:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:03 INFO - 'LOGNAME': 'cltbld', 05:15:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:15:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:03 INFO - 'MOZ_NO_REMOTE': '1', 05:15:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:15:03 INFO - 'NO_EM_RESTART': '1', 05:15:03 INFO - 'PAGER': '/bin/cat', 05:15:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:03 INFO - 'PWD': '/builds/slave/test', 05:15:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:15:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:03 INFO - 'SHELL': '/bin/bash', 05:15:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f31K0S4X6S/Listeners', 05:15:03 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 05:15:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:03 INFO - 'USER': 'cltbld', 05:15:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:03 INFO - 'XPC_FLAGS': '0x0', 05:15:03 INFO - 'XPC_SERVICE_NAME': '0', 05:15:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--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:15:03 INFO - mozversion application_buildid: 20160209030347 05:15:03 INFO - mozversion application_changeset: d1a54ae63da7ebc4bc1eeb5b613e8ec29bfcb80a 05:15:03 INFO - mozversion application_display_name: Nightly 05:15:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:15:03 INFO - mozversion application_name: Firefox 05:15:03 INFO - mozversion application_remotingname: firefox 05:15:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:15:03 INFO - mozversion application_vendor: Mozilla 05:15:03 INFO - mozversion application_version: 47.0a1 05:15:03 INFO - mozversion platform_buildid: 20160209030347 05:15:03 INFO - mozversion platform_changeset: d1a54ae63da7ebc4bc1eeb5b613e8ec29bfcb80a 05:15:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:15:03 INFO - mozversion platform_version: 47.0a1 05:15:03 INFO - using testdate: 1455023703 05:15:03 INFO - actual date: 1455023703 05:15:03 INFO - starting webserver on 'localhost:49274' 05:15:03 INFO - SUITE-START | Running 2 tests 05:15:03 INFO - TEST-START | dromaeo_css 05:15:03 INFO - operating with platform_type : mac_ 05:15:03 INFO - Initialising browser for dromaeo_css test... 05:15:03 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpQXgmgI/profile http://localhost:49274/getInfo.html) 05:15:06 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 05:15:06 INFO - PROCESS | 1680 | colorDepth:24 05:15:06 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 05:15:06 INFO - PROCESS | 1680 | __metrics 05:15:07 INFO - TEST-INFO | 1680: exit 0 05:15:07 INFO - Browser initialized. 05:15:07 INFO - Running cycle 1/1 for dromaeo_css test... 05:15:07 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpQXgmgI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:19 INFO - PROCESS | 1686 | RSS: Main: 258772992 05:15:19 INFO - PROCESS | 1686 | 05:16:09 INFO - PROCESS | 1686 | 1455023769346 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:18:19 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 05:18:21 INFO - PROCESS | 1686 | RSS: Main: 271937536 05:18:21 INFO - PROCESS | 1686 | 05:21:23 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 05:21:24 INFO - PROCESS | 1686 | RSS: Main: 283869184 05:21:24 INFO - PROCESS | 1686 | 05:24:25 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 05:24:26 INFO - PROCESS | 1686 | RSS: Main: 285208576 05:24:26 INFO - PROCESS | 1686 | 05:27:28 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 05:27:28 INFO - PROCESS | 1686 | RSS: Main: 287129600 05:27:28 INFO - PROCESS | 1686 | 05:30:31 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 05:30:31 INFO - PROCESS | 1686 | RSS: Main: 289058816 05:30:31 INFO - PROCESS | 1686 | 05:33:34 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 05:33:34 INFO - PROCESS | 1686 | RSS: Main: 290709504 05:33:34 INFO - PROCESS | 1686 | 05:33:34 INFO - PROCESS | 1686 | __start_tp_report 05:33:34 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 05:33:34 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 05:33:34 INFO - PROCESS | 1686 | |i|pagename|runs| 05:33:34 INFO - PROCESS | 1686 | |0;dojo.html;3564.750467467277;3592.425211966084;3601.1537288737127;3616.3490571697084;3648.325059863925;5764;5820.738066786994;5890.734916928744;5909.645421274727;5928.762849486026;5696.145578163278;5733.254676891998;5765.538756899438;5897.20387747654;6034.6379217246995;5211;5242.161254199329;5242.8689282767855;5308.097623404031;5369.731513424333;5207.843764687065;5313.814016509423;5321.680699158062;5375.166849138371;5390.973045134769;4417.558244175589;5228.424873263938;5242.8165014224505;5322.92015619766;5389.137737961907;4451.755153466558;5168.3539557555305;5282.788688452457;5291.126964050927;5311;5143.588512918957;5212.50481204285;5278.709670968095;5295.735213239361;5373.543248823855;5658.7170641467765;5768.913466298009;5787;5795.797147099831;5808.854778630526;6184.103305020792;6215.409536094064;6231.906521402183;6232.626042437423;6252.124702541648;5385.272988146589;6153.538484613627;6212.875742485125;6229.532785041095;6300.716467758962;6015.879682406327;6047.939520604782;6055.485283750931;6068.514518838527;6070.2108725865355;6218.378162183836;6293;6405.583637063576;6407.775727849503;6414.807555773335;6229.937700622936;6240;6263.342349053284;6283;6304.590201636879;6262.812115636447;6284.497240220771;6288.025356069725;6291.842703932347;6295.307516173218;5734.856628584319;5908.172855800191;6140.17107690465;6146.108814221912;6221.222347206599;6172.22847144107;6200.968995155085;6213;6230.470410015108;6230.59501132425;4879.463259041502;4918.991606720614;4994.200927851526;4996.1007018736245;4996.150654388763;4400.647948164139;4449.9555004450185;4475.664325175625;4503.842365517256;4531.705439146445;5396.406395296514;5688.77244910199;5714.857128571736;5715.828525144169;5716.942830571724;5129.8717532061255;5267.236250743621;6240.570703487994;6241.500679945684;6278.937210627927;4912.631552633496;5872.58891877573;5889.23439952812;5903.527717782567;5904.527637788967;5468.425815289337;5474.972625136849;5475.616706830563;5480.177973303957;5490;6286.339934306832;6378.808635740936;6451.580647257913;6461.2892581816905;6495.935040649628;5293.364796224478;6252.437280644764;6272.40412160844;6273.592216505913;6293.622382657055;6255.186825712628;6395.776147834989;6476.676166191577;6510.283868774526;6531.020346947806;6220.129181914445;6223.875522489434;6232.875342493216;6235.095911092957;6235.127082208403;5775.653460792366;6073.392660734068;6219.346968568416;6234.096056071935;6247.750089996349;6001.189839371629;6125.1424800527075;6126.334466363025;6205.379462053758;6210.472109870531;6175.814725558241;6179.81460556184;6185.41238582334;6211.192544969125;6228.0969259456215;5224.399194092576;6069.666168360783;6143.416375444325;6150.815475535741;6158.291796443466;6109.200087487409;6158.137860699595;6178.505719542336;6211.689415529296;6216.378362163929;6087.208662873798;6114.113453549122;6125.908111378244;6149.200603921461;6154.1999540059505 05:33:34 INFO - PROCESS | 1686 | |1;ext.html;432.08398195824856;446.2168893591746;481.5184815184815;580.4601720400028;653.3042309939916;32200.677993220062;37882.621173788255;38021;38069;38191.04522386938;39171;39282;39852.40221396674;39924.600753992454;40005;9364.531773411336;9525.142737153656;9578.892643618392;9622.903770962306;9628.711138665816;9506.47714375709;9736.269779766546;9754.46350450725;9757.609695612167;9802.607895684165;9707.514624268793;9730.221582273436;9737.95131024344;9803.362781419184;9827.410355378664;9649.614015439374;9702.27232957524;9741.756456088619;9761.316707830454;9788.51057447132;9537.618495260182;9645.276604254708;9673.984231655646;9687;9703;37703.81148094269;37770.622293776985;37978.81010594957;37995.81002094972;38327.80836095801;2986.522156454957;3179.6184457865206;3297.1921879139763;3625.111847597329;3910.081130934228;21656.56686866254;26263.21210363692;28191.57712634312;28261.71738282632;28415.857920710263;2508.109621084507;2588.094167041539;2724.4006318610072;2751.6697996240378;2860.985695071511;424502;424789;426300;426782;426841;56153.43846561564;62022.68988655028;62299.377006230265;66078;66621.66689166523;62334.688326558986;62573.37426625675;62948.37051629517;63230;63241.051384228354;16285.430009949832;16331.101789401459;16420.425285114965;16434.506964791075;16558;12113.091518136174;12409.503619855284;12532.185407948455;12548.12163148589;12659.36703164838;16727.414540491267;17673.790776152982;19981.100850461764;20221.595568088556;20226;8607.655693772303;8766.181876298459;8804.32717783619;8814.471131732116;8841.55792210387;919.9402038867452;967.6226271754022;1011.9392836429838;1013.6249587652468;1056.693558867935;28048.158555243375;29453.85273073621;29491.410171796444;29524.557131643043;29863.104106876828;1013.1995723378595;1152.6772503698978;1159.1596092832797;1168.8480497535265;1215.905684883612;14920.70158596822;14934;14982.925085374722;15198.544043678707;15229.466968656045;445884;446799.5320046823;447258;454856;456417;56703.43296567064;57038.714806425705;57368.13947790786;57480.71259643759;57847;1410.7249086428253;1447.3993292783377;1453.774664926938;1454.3673502026652;1469.8309694385282;29375.55936660909;29378.853105734335;29486.820527178672;29529.704702953553;29742;50679.23981140212;50722.492775071776;50821;51049.48950510596;51202.48797511977;370082;370352;373030;373446.1327693344;374400;30064.699353006188;32453;33343.99968000964;33364.332713346084;33453.33093338071;39912.80043599763;40907.59092409157;41194.38208426936;41686.58313416827;41999;34006.82996585001;35089.473657895665;35169.82415087908;35324;35514.467282990256;35118.82440587781;39965;41400.79299603483;42067.57932420637;42260.36609450922;38127.42808857925;38332.59175194888;38940.610593893696;38951.6104838948;39602.00994975149;36304.27391452209;37721.81139094287;37853.621463785006;38029.429558557196;38634;30220.11655278534;30525;30546.778128874597;31046.379072417974;31748.841255793574 05:33:34 INFO - PROCESS | 1686 | |2;jquery.html;318.7051976921348;356.63266835159794;358.6592736899944;364.25328077441253;367.2141616939748;15325.233738313096;18490.630187396262;19050.42848714539;19382.12780424881;20024.89863057533;18878;18996.145173467226;19209.519762005923;19271.325503607375;19382.321618743346;4872.83052067503;5549.77800887965;5725.627834190765;5856.590038697293;5859.941400585983;5216.66091704038;5663.461971112738;5674;5691.117876729114;5697.259356283698;3824.3307421201316;4347.869563913087;5456.317960254968;5480;5853.765849366042;5639.887202255973;5809;5824.621399609033;5850.9414905851245;5873.735681894325;5465;5474.315710536183;5517.806876759334;5565.693886836222;5599.048161812501;12766.170198937132;13001.479940802357;18132.728009079874;22660.640361578193;22824.08703651852;1668.3889712599744;2111.155537784883;2112.2501511963187;2185.2242453928784;2340.9063637454483;8543.487390756574;9386.20217281532;9409.682644429786;9955.75110622233;11626.476808543635;1743.7733094697608;1760.9735853962202;1773.5211492896974;1773.689604319239;1806.9819301806945;80588.98527536858;82639;88329;90839;92451;11003;11031.72420689473;11139.665810025712;11152.275102118336;11170.497327620114;13148.211107333591;13181.538646147339;13182.077254592086;13210.009249306147;13226.933865330611;6827.7710012197285;8409.873851892227;8411.537365444838;8447.915520844836;8462.153784621612;8467.53428561435;8488.448250863674;8496.447730897471;8541.231289184003;8578.699745509002;4232.534421213664;4312.482502099768;4357.651387888961;4371.0602220522105;4379.255526560492;1803.8545523592613;1839.0804597701149;1885.755950418997;1899.8480121590517;1920.5294702797903;701.7684164225793;732.8864026075967;791.8851766493826;801.7915342011119;815.6745288905529;15611.531654050397;17764.289428422977;18084;19454.513637159183;19692.50768730793;815.9551224682581;889.235257678396;891.2869704236584;954.379653225409;955.7610597350663;8206.712765053195;8240.917590824134;8410.873836892451;9604.66383676568;10530;539447;670919;682608;764704;765286;109250;111521.44239278752;113528;120952;125065;1194.7729931313022;1199.6341115959542;1200.1179133337164;1206.831043653889;1217.6407959651924;15279.61800954985;18318.542036449195;18485.35301264503;18609.90695046516;18931;52446;52602.47397526129;53470.64263753905;53606.73196633992;54085.72957135189;45596;70721.64639176772;72232.47186348452;72868.90696639448;74692;6491.221053473613;7278.871774874903;7428.73999410018;7548.245175482408;7562.810929726581;9840.803183936425;9989.500524973577;11315.264507806965;11755.47100380502;12100.939495302468;8905.862592977768;9964;10588.629397971034;10662.520186591777;10724.785504290026;9924.503774811375;10276.640317589148;10444.529996150039;10446.112080472942;10454.163666906781;9568.712938611852;10138.442385668564;10717.624883129052;11023.669289921316;11059.778804424028;7613.390928725578;7662.540247585162;7687.88468172989;7807.180246074307;7808.41436892224;7991.800204994922;9258.95370523143;10517.684469465928;10781.838272425763;10866.185036122164 05:33:34 INFO - PROCESS | 1686 | |3;mootools.html;1338.678717107894;1540.9383624655015;1710.3500669745495;1862.115495139808;1877.296013994752;7906.881396779053;8518.488890666564;8701.73894783156;8905.975812781531;8937.865932011016;8633.913660863389;8681.565921703921;8795.95602021989;8803.20771130598;8820.029796722372;2448.730639629648;2465.716442609096;2474.2824580871525;2478.281298423455;2479.454520005605;2428.465737537748;2449.6570480132796;2482.565551028563;2496.1762618335997;2505.5740524110943;2188.3872515695552;2413.8913748881255;2439.292605144506;2454.7299797022315;2473.010795681733;2432.2824766693866;2442.0842184180933;2449.424385269478;2478.5414698280783;2487.1916627096266;2422.1522467136538;2435.773932227584;2449.167283123729;2454.5336386086765;2454.803615710739;8755.781105472413;8774.429662071945;8814.911850881474;8827.69103081389;8835.293176545862;5361.249425080492;5471.671699698031;5473.17902314652;5487.122060470306;5514.283143191399;2841.559558268472;3073.769467289962;3631.2192878530977;3710.461983012448;3750.643688849555;1043.9530221140067;1087.7008822573775;1090.9509072091776;1107.8449017137607;1110.36154211328;11481.598144065001;11623.070154387713;11909.94045029778;11954.222975506564;11979.46092425843;4881.926771098437;4931.457539670633;4957.429895562056;4977.477364876709;4985.626078044161;8792.648294068165;10143.543540540693;10187.439690817077;10271.74320641975;10281.485925703684;5417.133258678593;5471.644343117685;5477.507024367826;5480.205370221295;5489.176623506426;4792.880177995508;4852.441969173519;4919;4949.183384741477;4975.651704380659;3985.8206380712936;3997.4603428537357;4001.5398229203433;4020.557738648746;4032.7781971991235;1219.969500762488;1302.049503862167;1303.4004357995238;1318.723068155698;1325.357201757147;1092.1372116028408;1095.222392101601;1121.3440137519642;1249.1256120715536;1323.3052647360214;8054.798630034296;8107.14874938123;8127.349812015024;8144.918550814416;8308.750737477885;1023.7594165371132;1143.2911594811271;1161.953521859116;1169.9590514331958;1197.8562572491358;6278.905816412757;6310.716017779211;6351.745930162834;6354.936450635527;6361.872762544724;8839.734807955772;10452.216083793746;10533.210009249184;10823.891761082446;10867.239293249555;10593.682189534326;10754.784904302027;10796.298240614335;10823.404712740718;10883.401412922207;8156.836863262702;8298;8319.792005199797;8322.750317490485;8349.624266908004;7717.421193410629;7879.645415956181;7910.2089791020435;7989.960050199712;7997.440179187401;9203.815923681355;9519.28605354615;9598.712038638852;9653.855192172263;9734.221262299141;9646.517674116125;9998.900010999796;10036.447995360326;10078;10158.136558392323;7073.681684324115;7212.819679508054;7260.237675044044;7272.127344718668;7299.4160467163565;6903.585784852925;7991.001124859393;8378.874316885374;8411.074781774123;8444.408891377545;7754.6898124074405;7880.936073629987;7931;7992.40056995716;7995.480293780885;7642;7711.922880771345;7756.379489640703;7759.922400776146;7903.644336004779;7758.728444504415;7782.727604533814;7831;7949.244821741925;7956.482828616122;7041.894371584533;7193.208747037717;7194;7199.208087110309;7234;7228.891566626399;7257.891131632924;7296.124465064227;7297.16082650502;7301.306375894282 05:33:34 INFO - PROCESS | 1686 | |4;prototype.html;324.92364294390813;331.05483843626445;331.9568456100707;337.1924241441747;338.05513589517295;5987;6869.896951545731;6917.792466226015;6919.654017299127;7013.929860701392;6817.590944543331;6828.770821252173;6847.349501797334;6864.759733409319;6926.341997510229;5104.157813960701;5115.514026167527;5115.616328775357;5128.640995130342;5142.820001299955;4800.735959522225;5104.64267501275;5115.718635475047;5121.718305493197;5130.127878260705;4879.170541008019;4888.755562221892;4894.53501917319;4909.263610458424;4933.038057578774;4271.273883439822;4706.717596944194;4857.198562237227;4874.512548745132;4888.144574699413;3214.1964508872784;3964.86122985697;4002.899927501807;4129.772862492562;4182.665386769082;6077.453029227391;6534.771283005072;6560.671966401661;6588.736450541973;6639.73441062357;5027.698338099725;5255.789768409259;5380.461953804588;5688.83378907323;5859.707014649251;7111.9332100184865;7311.780646580611;7313.817154571178;7322.853542929165;7351.375133113692;4127.876163715094;4653;4661.114388266218;4668;4672;6593.769218077392;7380.188179300273;7582.734604288823;7793.805154871116;7809.336206422404;4598.126355992351;4734.100520901018;4737.763111844394;4750.358701575243;4773.809047638125;4850.442199147073;4858.975705121452;4861.173600487926;4867.3915760529935;4870.488598697157;4759.809607615726;5822.621529600562;5866.445391971131;5866.6186697864505;5881;7392.815179620445;7414.406847452191;7414.962925185448;7439.218882017419;7456.552606843607;1267.3283159925254;1605.2054233154663;1654.487108996191;1654.5770637251953;1665.991670041642;1058.6771034834449;1068.0814499530397;1074.9197056957707;1077.2513103393067;1081.5727787523883;6021.969890150521;6290.930541807904;6724.697388617524;6729.22613899398;6744.730210791611;7636.8472630548185;7656.655450504741;7671.769846904602;7689.077310722749;7699;6521.315261897527;6769.458443324522;6769.8646027079185;6773.424258937947;6774.187097548326;3927.430522574211;3977.1846771411792;3977.980110099431;3981.243563722883;3981.8407263709128;8005.719799806979;8008;8025.799355016171;8046.517208967481;8057.395695322874;7919.168487308865;7927.167647397056;7954.363650907913;8036.638351274207;8064.919350806535;7855.8821617675785;8154.347652187929;8165.2243036911395;8177.632006559719;8178.427510074238;7788.532688038736;7789.221077892165;7808.063032436144;7808.49244799109;7883.014623172104;6228.532860035606;7357.411407087528;7632.38940884739;7657.502262352929;7664.540127592362;6538.8365290868105;8144.67421303165;8166.550839703873;8180;8187.79530511742;4758.952410475851;4800.255960326155;4803.759812009455;4803.783829727601;4810.42274927011;7433.368163706145;7678.078630564368;7741.7677469676;7742.38060955111;7807.492512986638;7502.249775022454;7517;7520.09758828944;7540.886886696813;7541.509801862861;7215.386692131227;7501.512401693873;7502.737404191045;7503.624818758931;7514.323710866049;7313.012743279589;7330.560166390033;7357.2642735726;7360.263973602597;7376.704931802882;7490.363319117936;7502.512336698097;7517.699292028257;7534.4725869190825;7538;6292;7135.500514963903;7309.378702810321;7338.633068346455;7366.7053317866685 05:33:34 INFO - PROCESS | 1686 | |5;yui.html;672.663668165917;673.219065883575;692.1901375390793;723.5043994863519;743.3755645257983;12383.44274507647;14664.926675366622;14852.777208341884;15135.091894486339;15160.39358425663;13812.309384530783;13828.792568111487;13868.722625547483;13896.791548126786;13907;681.788645519888;834.9332053435726;844.0420123160227;852.40757673417;857.6140736668524;730.280673536566;841.4908980067063;845.3364109174299;848.4909054567272;859.0893652728097;884.3765145572356;907.7594437474074;908.2688435809171;908.900020997693;911.7401540560942;890.4523717913469;895.5164211325877;896.551724137931;903.8282726282018;906.0305473143673;669.4142625202948;676.5974245324024;679.8334408070006;680.6868840333452;680.7821497120923;14592.051516651383;14837.406503739838;14844;14876.330565124486;14906.70186596262;12775.936120319338;12889.226646401246;13007.674808129777;13255.337233138305;13410.195388276637;10304;10344.844827327595;10392.688219353431;10413.095089341497;10875.293105948089;3453.4992426098074;3503.737219708532;3519.278547897675;3526.6473352664784;3543.450765131409;79196;79709;81086.59456702738;81544;81640.59179704063;8045.798855028671;9563.378380405251;9675.612975480903;9967.700968970943;10334.431606261578;20969.68545471819;21363;21821.563568728536;21837.563248734936;21873;7254.310840470147;7455.030845989987;7504.249575042561;7717.151113377524;7799.064112306446;4050.2396989202557;4083.7753923533896;4136.420901073852;4177.6866734995;4313.309870420718;3501.8074005929407;3515.261795023023;3538.7876727396438;3540.8760693375607;3560.0565850049757;626.6208943589063;642.4474951541764;642.6979319719725;644.2816259870211;654.3227759269133;501.6739119572307;574.3280361976498;582.7727186397224;599.409581562161;603.538293205698;8327.125651806473;8393.6222869971;8412.369072319601;8583.39916205872;8636.309095272363;506.6731957887142;576.2537513919484;605.7243954000919;609.8536351275751;637.5027478566725;3891.3968334908136;3963.385675220288;3973.0861901762755;4031;4067.8372865085066;90133;91421;91777.0822291782;91778;92456.53771731099;62060.68969655123;78899;79161;79410.6029469849;80977.19022809814;66111.66944165344;68587.65706171437;69911;70352.94470582945;71192;8081.313088387553;8108.067572229269;8140.918590814016;8241;8291.212334828182;48095.82370996869;48694;49328.01343973029;49352;49792.502074980235;52733.209001864234;57241.42758572527;58401;58971.82056358763;59015.704921476834;10889;10983.286086404358;11123.499442524944;11346.978771910568;11647.30116193031;11908.273300371224;12305.753884922431;12309.507619695112;12431.62705118848;12804.29576373271;11080.279781814157;11090.833637495283;11706.70733231676;11773.52905883755;12250.816237756262;11265.317512919271;11313.7737245253;11329.71675708114;11656.708582285512;12284.81572776427;10547.314424562379;11249;11325.660230193107;11598.420078996185;11618.6514404568;9089.63641454361;9131.863022054542;9147.268218542633;9427.528623568931;10064.798704026025;9119.863202052107;9179.954100229455;9486.573104210465;9822.607095716377;10138.03688649577 05:33:34 INFO - PROCESS | 1686 | __end_tp_report 05:33:34 INFO - PROCESS | 1686 | __start_cc_report 05:33:34 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,365 05:33:34 INFO - PROCESS | 1686 | __end_cc_report 05:33:34 INFO - PROCESS | 1686 | __startTimestamp1455024814453__endTimestamp 05:33:34 INFO - PROCESS | 1686 | 05:33:34 INFO - PROCESS | 1686 | ------- Summary: start ------- 05:33:34 INFO - PROCESS | 1686 | Number of tests: 6 05:33:34 INFO - PROCESS | 1686 | 05:33:34 INFO - PROCESS | 1686 | [#0] dojo.html Cycles:165 Average:5773.62 Median:6068.51 stddev:637.42 (10.5%) stddev-sans-first:615.37 05:33:34 INFO - PROCESS | 1686 | Values: 3564.8 3592.4 3601.2 3616.3 3648.3 5764.0 5820.7 5890.7 5909.6 5928.8 5696.1 5733.3 5765.5 5897.2 6034.6 5211.0 5242.2 5242.9 5308.1 5369.7 5207.8 5313.8 5321.7 5375.2 5391.0 4417.6 5228.4 5242.8 5322.9 5389.1 4451.8 5168.4 5282.8 5291.1 5311.0 5143.6 5212.5 5278.7 5295.7 5373.5 5658.7 5768.9 5787.0 5795.8 5808.9 6184.1 6215.4 6231.9 6232.6 6252.1 5385.3 6153.5 6212.9 6229.5 6300.7 6015.9 6047.9 6055.5 6068.5 6070.2 6218.4 6293.0 6405.6 6407.8 6414.8 6229.9 6240.0 6263.3 6283.0 6304.6 6262.8 6284.5 6288.0 6291.8 6295.3 5734.9 5908.2 6140.2 6146.1 6221.2 6172.2 6201.0 6213.0 6230.5 6230.6 4879.5 4919.0 4994.2 4996.1 4996.2 4400.6 4450.0 4475.7 4503.8 4531.7 5396.4 5688.8 5714.9 5715.8 5716.9 5129.9 5267.2 6240.6 6241.5 6278.9 4912.6 5872.6 5889.2 5903.5 5904.5 5468.4 5475.0 5475.6 5480.2 5490.0 6286.3 6378.8 6451.6 6461.3 6495.9 5293.4 6252.4 6272.4 6273.6 6293.6 6255.2 6395.8 6476.7 6510.3 6531.0 6220.1 6223.9 6232.9 6235.1 6235.1 5775.7 6073.4 6219.3 6234.1 6247.8 6001.2 6125.1 6126.3 6205.4 6210.5 6175.8 6179.8 6185.4 6211.2 6228.1 5224.4 6069.7 6143.4 6150.8 6158.3 6109.2 6158.1 6178.5 6211.7 6216.4 6087.2 6114.1 6125.9 6149.2 6154.2 05:33:34 INFO - PROCESS | 1686 | 05:33:34 INFO - PROCESS | 1686 | [#1] ext.html Cycles:180 Average:57451.29 Median:38159.24 stddev:110291.49 (289.0%) stddev-sans-first:110517.80 05:33:34 INFO - PROCESS | 1686 | Values: 432.1 446.2 481.5 580.5 653.3 32200.7 37882.6 38021.0 38069.0 38191.0 39171.0 39282.0 39852.4 39924.6 40005.0 9364.5 9525.1 9578.9 9622.9 9628.7 9506.5 9736.3 9754.5 9757.6 9802.6 9707.5 9730.2 9738.0 9803.4 9827.4 9649.6 9702.3 9741.8 9761.3 9788.5 9537.6 9645.3 9674.0 9687.0 9703.0 37703.8 37770.6 37978.8 37995.8 38327.8 2986.5 3179.6 3297.2 3625.1 3910.1 21656.6 26263.2 28191.6 28261.7 28415.9 2508.1 2588.1 2724.4 2751.7 2861.0 424502.0 424789.0 426300.0 426782.0 426841.0 56153.4 62022.7 62299.4 66078.0 66621.7 62334.7 62573.4 62948.4 63230.0 63241.1 16285.4 16331.1 16420.4 16434.5 16558.0 12113.1 12409.5 12532.2 12548.1 12659.4 16727.4 17673.8 19981.1 20221.6 20226.0 8607.7 8766.2 8804.3 8814.5 8841.6 919.9 967.6 1011.9 1013.6 1056.7 28048.2 29453.9 29491.4 29524.6 29863.1 1013.2 1152.7 1159.2 1168.8 1215.9 14920.7 14934.0 14982.9 15198.5 15229.5 445884.0 446799.5 447258.0 454856.0 456417.0 56703.4 57038.7 57368.1 57480.7 57847.0 1410.7 1447.4 1453.8 1454.4 1469.8 29375.6 29378.9 29486.8 29529.7 29742.0 50679.2 50722.5 50821.0 51049.5 51202.5 370082.0 370352.0 373030.0 373446.1 374400.0 30064.7 32453.0 33344.0 33364.3 33453.3 39912.8 40907.6 41194.4 41686.6 41999.0 34006.8 35089.5 35169.8 35324.0 35514.5 35118.8 39965.0 41400.8 42067.6 42260.4 38127.4 38332.6 38940.6 38951.6 39602.0 36304.3 37721.8 37853.6 38029.4 38634.0 30220.1 30525.0 30546.8 31046.4 31748.8 05:33:34 INFO - PROCESS | 1686 | 05:33:34 INFO - PROCESS | 1686 | [#2] jquery.html Cycles:180 Average:35192.11 Median:24987.63 stddev:113678.85 (454.9%) stddev-sans-first:113967.59 05:33:34 INFO - PROCESS | 1686 | Values: 318.7 356.6 358.7 364.3 367.2 15325.2 18490.6 19050.4 19382.1 20024.9 18878.0 18996.1 19209.5 19271.3 19382.3 4872.8 5549.8 5725.6 5856.6 5859.9 5216.7 5663.5 5674.0 5691.1 5697.3 3824.3 4347.9 5456.3 5480.0 5853.8 5639.9 5809.0 5824.6 5850.9 5873.7 5465.0 5474.3 5517.8 5565.7 5599.0 12766.2 13001.5 18132.7 22660.6 22824.1 1668.4 2111.2 2112.3 2185.2 2340.9 8543.5 9386.2 9409.7 9955.8 11626.5 1743.8 1761.0 1773.5 1773.7 1807.0 80589.0 82639.0 88329.0 90839.0 92451.0 11003.0 11031.7 11139.7 11152.3 11170.5 13148.2 13181.5 13182.1 13210.0 13226.9 6827.8 8409.9 8411.5 8447.9 8462.2 8467.5 8488.4 8496.4 8541.2 8578.7 4232.5 4312.5 4357.7 4371.1 4379.3 1803.9 1839.1 1885.8 1899.8 1920.5 701.8 732.9 791.9 801.8 815.7 15611.5 17764.3 18084.0 19454.5 19692.5 816.0 889.2 891.3 954.4 955.8 8206.7 8240.9 8410.9 9604.7 10530.0 539447.0 670919.0 682608.0 764704.0 765286.0 109250.0 111521.4 113528.0 120952.0 125065.0 1194.8 1199.6 1200.1 1206.8 1217.6 15279.6 18318.5 18485.4 18609.9 18931.0 52446.0 52602.5 53470.6 53606.7 54085.7 45596.0 70721.6 72232.5 72868.9 74692.0 6491.2 7278.9 7428.7 7548.2 7562.8 9840.8 9989.5 11315.3 11755.5 12100.9 8905.9 9964.0 10588.6 10662.5 10724.8 9924.5 10276.6 10444.5 10446.1 10454.2 9568.7 10138.4 10717.6 11023.7 11059.8 7613.4 7662.5 7687.9 7807.2 7808.4 7991.8 9259.0 10517.7 10781.8 10866.2 05:33:34 INFO - PROCESS | 1686 | 05:33:34 INFO - PROCESS | 1686 | [#3] mootools.html Cycles:180 Average:6087.16 Median:5173.44 stddev:3185.82 (61.6%) stddev-sans-first:3174.75 05:33:34 INFO - PROCESS | 1686 | Values: 1338.7 1540.9 1710.4 1862.1 1877.3 7906.9 8518.5 8701.7 8906.0 8937.9 8633.9 8681.6 8796.0 8803.2 8820.0 2448.7 2465.7 2474.3 2478.3 2479.5 2428.5 2449.7 2482.6 2496.2 2505.6 2188.4 2413.9 2439.3 2454.7 2473.0 2432.3 2442.1 2449.4 2478.5 2487.2 2422.2 2435.8 2449.2 2454.5 2454.8 8755.8 8774.4 8814.9 8827.7 8835.3 5361.2 5471.7 5473.2 5487.1 5514.3 2841.6 3073.8 3631.2 3710.5 3750.6 1044.0 1087.7 1091.0 1107.8 1110.4 11481.6 11623.1 11909.9 11954.2 11979.5 4881.9 4931.5 4957.4 4977.5 4985.6 8792.6 10143.5 10187.4 10271.7 10281.5 5417.1 5471.6 5477.5 5480.2 5489.2 4792.9 4852.4 4919.0 4949.2 4975.7 3985.8 3997.5 4001.5 4020.6 4032.8 1220.0 1302.0 1303.4 1318.7 1325.4 1092.1 1095.2 1121.3 1249.1 1323.3 8054.8 8107.1 8127.3 8144.9 8308.8 1023.8 1143.3 1162.0 1170.0 1197.9 6278.9 6310.7 6351.7 6354.9 6361.9 8839.7 10452.2 10533.2 10823.9 10867.2 10593.7 10754.8 10796.3 10823.4 10883.4 8156.8 8298.0 8319.8 8322.8 8349.6 7717.4 7879.6 7910.2 7990.0 7997.4 9203.8 9519.3 9598.7 9653.9 9734.2 9646.5 9998.9 10036.4 10078.0 10158.1 7073.7 7212.8 7260.2 7272.1 7299.4 6903.6 7991.0 8378.9 8411.1 8444.4 7754.7 7880.9 7931.0 7992.4 7995.5 7642.0 7711.9 7756.4 7759.9 7903.6 7758.7 7782.7 7831.0 7949.2 7956.5 7041.9 7193.2 7194.0 7199.2 7234.0 7228.9 7257.9 7296.1 7297.2 7301.3 05:33:34 INFO - PROCESS | 1686 | 05:33:34 INFO - PROCESS | 1686 | [#4] prototype.html Cycles:180 Average:5984.78 Median:6757.09 stddev:1993.06 (29.5%) stddev-sans-first:1952.85 05:33:34 INFO - PROCESS | 1686 | Values: 324.9 331.1 332.0 337.2 338.1 5987.0 6869.9 6917.8 6919.7 7013.9 6817.6 6828.8 6847.3 6864.8 6926.3 5104.2 5115.5 5115.6 5128.6 5142.8 4800.7 5104.6 5115.7 5121.7 5130.1 4879.2 4888.8 4894.5 4909.3 4933.0 4271.3 4706.7 4857.2 4874.5 4888.1 3214.2 3964.9 4002.9 4129.8 4182.7 6077.5 6534.8 6560.7 6588.7 6639.7 5027.7 5255.8 5380.5 5688.8 5859.7 7111.9 7311.8 7313.8 7322.9 7351.4 4127.9 4653.0 4661.1 4668.0 4672.0 6593.8 7380.2 7582.7 7793.8 7809.3 4598.1 4734.1 4737.8 4750.4 4773.8 4850.4 4859.0 4861.2 4867.4 4870.5 4759.8 5822.6 5866.4 5866.6 5881.0 7392.8 7414.4 7415.0 7439.2 7456.6 1267.3 1605.2 1654.5 1654.6 1666.0 1058.7 1068.1 1074.9 1077.3 1081.6 6022.0 6290.9 6724.7 6729.2 6744.7 7636.8 7656.7 7671.8 7689.1 7699.0 6521.3 6769.5 6769.9 6773.4 6774.2 3927.4 3977.2 3978.0 3981.2 3981.8 8005.7 8008.0 8025.8 8046.5 8057.4 7919.2 7927.2 7954.4 8036.6 8064.9 7855.9 8154.3 8165.2 8177.6 8178.4 7788.5 7789.2 7808.1 7808.5 7883.0 6228.5 7357.4 7632.4 7657.5 7664.5 6538.8 8144.7 8166.6 8180.0 8187.8 4759.0 4800.3 4803.8 4803.8 4810.4 7433.4 7678.1 7741.8 7742.4 7807.5 7502.2 7517.0 7520.1 7540.9 7541.5 7215.4 7501.5 7502.7 7503.6 7514.3 7313.0 7330.6 7357.3 7360.3 7376.7 7490.4 7502.5 7517.7 7534.5 7538.0 6292.0 7135.5 7309.4 7338.6 7366.7 05:33:34 INFO - PROCESS | 1686 | 05:33:34 INFO - PROCESS | 1686 | [#5] yui.html Cycles:180 Average:17900.63 Median:58686.41 stddev:24925.52 (42.5%) stddev-sans-first:24961.88 05:33:34 INFO - PROCESS | 1686 | Values: 672.7 673.2 692.2 723.5 743.4 12383.4 14664.9 14852.8 15135.1 15160.4 13812.3 13828.8 13868.7 13896.8 13907.0 681.8 834.9 844.0 852.4 857.6 730.3 841.5 845.3 848.5 859.1 884.4 907.8 908.3 908.9 911.7 890.5 895.5 896.6 903.8 906.0 669.4 676.6 679.8 680.7 680.8 14592.1 14837.4 14844.0 14876.3 14906.7 12775.9 12889.2 13007.7 13255.3 13410.2 10304.0 10344.8 10392.7 10413.1 10875.3 3453.5 3503.7 3519.3 3526.6 3543.5 79196.0 79709.0 81086.6 81544.0 81640.6 8045.8 9563.4 9675.6 9967.7 10334.4 20969.7 21363.0 21821.6 21837.6 21873.0 7254.3 7455.0 7504.2 7717.2 7799.1 4050.2 4083.8 4136.4 4177.7 4313.3 3501.8 3515.3 3538.8 3540.9 3560.1 626.6 642.4 642.7 644.3 654.3 501.7 574.3 582.8 599.4 603.5 8327.1 8393.6 8412.4 8583.4 8636.3 506.7 576.3 605.7 609.9 637.5 3891.4 3963.4 3973.1 4031.0 4067.8 90133.0 91421.0 91777.1 91778.0 92456.5 62060.7 78899.0 79161.0 79410.6 80977.2 66111.7 68587.7 69911.0 70352.9 71192.0 8081.3 8108.1 8140.9 8241.0 8291.2 48095.8 48694.0 49328.0 49352.0 49792.5 52733.2 57241.4 58401.0 58971.8 59015.7 10889.0 10983.3 11123.5 11347.0 11647.3 11908.3 12305.8 12309.5 12431.6 12804.3 11080.3 11090.8 11706.7 11773.5 12250.8 11265.3 11313.8 11329.7 11656.7 12284.8 10547.3 11249.0 11325.7 11598.4 11618.7 9089.6 9131.9 9147.3 9427.5 10064.8 9119.9 9180.0 9486.6 9822.6 10138.0 05:33:34 INFO - PROCESS | 1686 | -------- Summary: end -------- 05:33:34 INFO - PROCESS | 1686 | 05:33:34 INFO - TEST-INFO | 1686: exit 0 05:33:34 INFO - TEST-OK | dromaeo_css | took 1111318ms 05:33:34 INFO - TEST-START | kraken 05:33:34 INFO - operating with platform_type : mac_ 05:33:34 INFO - Initialising browser for kraken test... 05:33:34 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpNpaqjw/profile http://localhost:49274/getInfo.html) 05:33:38 INFO - PROCESS | 1694 | __metrics Screen width/height:1600/1200 05:33:38 INFO - PROCESS | 1694 | colorDepth:24 05:33:38 INFO - PROCESS | 1694 | Browser inner width/height: 1024/689 05:33:38 INFO - PROCESS | 1694 | __metrics 05:33:38 INFO - TEST-INFO | 1694: exit 0 05:33:38 INFO - Browser initialized. 05:33:38 INFO - Running cycle 1/1 for kraken test... 05:33:38 INFO - TEST-INFO | started process 1698 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpNpaqjw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:50 INFO - PROCESS | 1698 | RSS: Main: 259133440 05:33:50 INFO - PROCESS | 1698 | 05:33:53 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 05:33:53 INFO - PROCESS | 1698 | RSS: Main: 269967360 05:33:53 INFO - PROCESS | 1698 | 05:33:56 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 05:33:57 INFO - PROCESS | 1698 | RSS: Main: 280174592 05:33:57 INFO - PROCESS | 1698 | 05:34:00 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 05:34:01 INFO - PROCESS | 1698 | RSS: Main: 283279360 05:34:01 INFO - PROCESS | 1698 | 05:34:03 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 05:34:03 INFO - PROCESS | 1698 | RSS: Main: 284659712 05:34:03 INFO - PROCESS | 1698 | 05:34:05 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:34:06 INFO - PROCESS | 1698 | RSS: Main: 285003776 05:34:06 INFO - PROCESS | 1698 | 05:34:09 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 05:34:09 INFO - PROCESS | 1698 | RSS: Main: 285356032 05:34:09 INFO - PROCESS | 1698 | 05:34:12 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 05:34:13 INFO - PROCESS | 1698 | RSS: Main: 285040640 05:34:13 INFO - PROCESS | 1698 | 05:34:16 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 05:34:16 INFO - PROCESS | 1698 | RSS: Main: 285929472 05:34:16 INFO - PROCESS | 1698 | 05:34:18 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:34:18 INFO - PROCESS | 1698 | RSS: Main: 285392896 05:34:18 INFO - PROCESS | 1698 | 05:34:20 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:34:21 INFO - PROCESS | 1698 | RSS: Main: 284712960 05:34:21 INFO - PROCESS | 1698 | 05:34:23 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:34:23 INFO - PROCESS | 1698 | RSS: Main: 286720000 05:34:23 INFO - PROCESS | 1698 | 05:34:26 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:34:27 INFO - PROCESS | 1698 | RSS: Main: 286011392 05:34:27 INFO - PROCESS | 1698 | 05:34:29 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:34:30 INFO - PROCESS | 1698 | RSS: Main: 286330880 05:34:30 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 05:34:32 INFO - PROCESS | 1698 | RSS: Main: 286932992 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | __start_tp_report 05:34:32 INFO - PROCESS | 1698 | _x_x_mozilla_page_load 05:34:32 INFO - PROCESS | 1698 | _x_x_mozilla_page_load_details 05:34:32 INFO - PROCESS | 1698 | |i|pagename|runs| 05:34:32 INFO - PROCESS | 1698 | |0;ai-astar;115;109;115;118;118;125;115;115;115;115 05:34:32 INFO - PROCESS | 1698 | |1;audio-beat-detection;154;124;148;158;123;140;143;123;158;155 05:34:32 INFO - PROCESS | 1698 | |2;audio-dft;193;201;197;198;205;224;199;197;201;201 05:34:32 INFO - PROCESS | 1698 | |3;audio-fft;60;61;73;70;141;83;90;69;63;92 05:34:32 INFO - PROCESS | 1698 | |4;audio-oscillator;81;87;115;79;80;81;116;82;81;112 05:34:32 INFO - PROCESS | 1698 | |5;imaging-gaussian-blur;89;127;86;96;88;93;86;104;131;94 05:34:32 INFO - PROCESS | 1698 | |6;imaging-darkroom;97;96;97;95;97;95;95;97;98;98 05:34:32 INFO - PROCESS | 1698 | |7;imaging-desaturate;95;94;125;143;101;90;99;87;92;93 05:34:32 INFO - PROCESS | 1698 | |8;json-parse-financial;58;57;54;58;57;56;55;64;57;55 05:34:32 INFO - PROCESS | 1698 | |9;json-stringify-tinderbox;65;64;63;72;72;65;66;67;67;71 05:34:32 INFO - PROCESS | 1698 | |10;stanford-crypto-aes;90;85;90;86;84;85;88;85;110;114 05:34:32 INFO - PROCESS | 1698 | |11;stanford-crypto-ccm;136;129;138;127;131;117;140;135;144;125 05:34:32 INFO - PROCESS | 1698 | |12;stanford-crypto-pbkdf2;163;178;140;143;158;138;168;145;126;179 05:34:32 INFO - PROCESS | 1698 | |13;stanford-crypto-sha256-iterative;67;70;66;67;69;68;63;83;71;59 05:34:32 INFO - PROCESS | 1698 | __end_tp_report 05:34:32 INFO - PROCESS | 1698 | __start_cc_report 05:34:32 INFO - PROCESS | 1698 | _x_x_mozilla_cycle_collect,932 05:34:32 INFO - PROCESS | 1698 | __end_cc_report 05:34:32 INFO - PROCESS | 1698 | __startTimestamp1455024872327__endTimestamp 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | ------- Summary: start ------- 05:34:32 INFO - PROCESS | 1698 | Number of tests: 14 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | [#0] ai-astar Cycles:10 Average:116.00 Median:115.00 stddev:4.00 (3.5%) stddev-sans-first:4.23 05:34:32 INFO - PROCESS | 1698 | Values: 115.0 109.0 115.0 118.0 118.0 125.0 115.0 115.0 115.0 115.0 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:151.00 stddev:14.56 (9.6%) stddev-sans-first:14.85 05:34:32 INFO - PROCESS | 1698 | Values: 154.0 124.0 148.0 158.0 123.0 140.0 143.0 123.0 158.0 155.0 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | [#2] audio-dft Cycles:10 Average:201.60 Median:201.00 stddev:8.50 (4.2%) stddev-sans-first:8.43 05:34:32 INFO - PROCESS | 1698 | Values: 193.0 201.0 197.0 198.0 205.0 224.0 199.0 197.0 201.0 201.0 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | [#3] audio-fft Cycles:10 Average:80.20 Median:71.50 stddev:24.25 (33.9%) stddev-sans-first:24.60 05:34:32 INFO - PROCESS | 1698 | Values: 60.0 61.0 73.0 70.0 141.0 83.0 90.0 69.0 63.0 92.0 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:81.00 stddev:15.99 (19.7%) stddev-sans-first:16.52 05:34:32 INFO - PROCESS | 1698 | Values: 81.0 87.0 115.0 79.0 80.0 81.0 116.0 82.0 81.0 112.0 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | [#5] imaging-gaussian-blur Cycles:10 Average:99.40 Median:88.50 stddev:16.53 (18.7%) stddev-sans-first:17.10 05:34:32 INFO - PROCESS | 1698 | Values: 89.0 127.0 86.0 96.0 88.0 93.0 86.0 104.0 131.0 94.0 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | [#6] imaging-darkroom Cycles:10 Average:96.50 Median:97.00 stddev:1.18 (1.2%) stddev-sans-first:1.24 05:34:32 INFO - PROCESS | 1698 | Values: 97.0 96.0 97.0 95.0 97.0 95.0 95.0 97.0 98.0 98.0 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | [#7] imaging-desaturate Cycles:10 Average:101.90 Median:92.50 stddev:17.90 (19.3%) stddev-sans-first:18.81 05:34:32 INFO - PROCESS | 1698 | Values: 95.0 94.0 125.0 143.0 101.0 90.0 99.0 87.0 92.0 93.0 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:2.77 (4.9%) stddev-sans-first:2.92 05:34:32 INFO - PROCESS | 1698 | Values: 58.0 57.0 54.0 58.0 57.0 56.0 55.0 64.0 57.0 55.0 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:3.33 (5.0%) stddev-sans-first:3.43 05:34:32 INFO - PROCESS | 1698 | Values: 65.0 64.0 63.0 72.0 72.0 65.0 66.0 67.0 67.0 71.0 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:85.50 stddev:10.94 (12.8%) stddev-sans-first:11.59 05:34:32 INFO - PROCESS | 1698 | Values: 90.0 85.0 90.0 86.0 84.0 85.0 88.0 85.0 110.0 114.0 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:135.50 stddev:8.01 (5.9%) stddev-sans-first:8.38 05:34:32 INFO - PROCESS | 1698 | Values: 136.0 129.0 138.0 127.0 131.0 117.0 140.0 135.0 144.0 125.0 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:160.50 stddev:18.05 (11.2%) stddev-sans-first:18.83 05:34:32 INFO - PROCESS | 1698 | Values: 163.0 178.0 140.0 143.0 158.0 138.0 168.0 145.0 126.0 179.0 05:34:32 INFO - PROCESS | 1698 | 05:34:32 INFO - PROCESS | 1698 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:6.24 (9.1%) stddev-sans-first:6.60 05:34:32 INFO - PROCESS | 1698 | Values: 67.0 70.0 66.0 67.0 69.0 68.0 63.0 83.0 71.0 59.0 05:34:32 INFO - PROCESS | 1698 | -------- Summary: end -------- 05:34:32 INFO - PROCESS | 1698 | 05:34:33 INFO - TEST-INFO | 1698: exit 0 05:34:33 INFO - TEST-OK | kraken | took 58103ms 05:34:33 INFO - SUITE-END | took 1169s 05:34:33 INFO - Completed test suite (00:19:29) 05:34:33 INFO - Working with test: dromaeo_css 05:34:33 INFO - Generating results file: dromaeo_css 05:34:33 INFO - Working with test: kraken 05:34:33 INFO - Generating results file: kraken 05:34:33 INFO - javascript benchmark 05:34:33 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:34:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 05:34:33 INFO - process_Request line: dromaeo_css 7504.85 graph.html#tests=[[72,1,61]] 05:34:33 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:34:33 INFO - process_Request line: kraken 1499.90 graph.html#tests=[[232,1,61]] 05:34:33 INFO - RETURN: dromaeo_css: 7504.85 05:34:33 INFO - RETURN: kraken: 1499.90 05:34:33 INFO - javascript benchmark 05:34:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3564.750467467277, 3592.425211966084, 3601.1537288737127, 3616.3490571697084, 3648.325059863925, 5764.0, 5820.738066786994, 5890.734916928744, 5909.645421274727, 5928.762849486026, 5696.145578163278, 5733.254676891998, 5765.538756899438, 5897.20387747654, 6034.6379217246995, 5211.0, 5242.161254199329, 5242.8689282767855, 5308.097623404031, 5369.731513424333, 5207.843764687065, 5313.814016509423, 5321.680699158062, 5375.166849138371, 5390.973045134769, 4417.558244175589, 5228.424873263938, 5242.8165014224505, 5322.92015619766, 5389.137737961907, 4451.755153466558, 5168.3539557555305, 5282.788688452457, 5291.126964050927, 5311.0, 5143.588512918957, 5212.50481204285, 5278.709670968095, 5295.735213239361, 5373.543248823855, 5658.7170641467765, 5768.913466298009, 5787.0, 5795.797147099831, 5808.854778630526, 6184.103305020792, 6215.409536094064, 6231.906521402183, 6232.626042437423, 6252.124702541648, 5385.272988146589, 6153.538484613627, 6212.875742485125, 6229.532785041095, 6300.716467758962, 6015.879682406327, 6047.939520604782, 6055.485283750931, 6068.514518838527, 6070.2108725865355, 6218.378162183836, 6293.0, 6405.583637063576, 6407.775727849503, 6414.807555773335, 6229.937700622936, 6240.0, 6263.342349053284, 6283.0, 6304.590201636879, 6262.812115636447, 6284.497240220771, 6288.025356069725, 6291.842703932347, 6295.307516173218, 5734.856628584319, 5908.172855800191, 6140.17107690465, 6146.108814221912, 6221.222347206599, 6172.22847144107, 6200.968995155085, 6213.0, 6230.470410015108, 6230.59501132425, 4879.463259041502, 4918.991606720614, 4994.200927851526, 4996.1007018736245, 4996.150654388763, 4400.647948164139, 4449.9555004450185, 4475.664325175625, 4503.842365517256, 4531.705439146445, 5396.406395296514, 5688.77244910199, 5714.857128571736, 5715.828525144169, 5716.942830571724, 5129.8717532061255, 5267.236250743621, 6240.570703487994, 6241.500679945684, 6278.937210627927, 4912.631552633496, 5872.58891877573, 5889.23439952812, 5903.527717782567, 5904.527637788967, 5468.425815289337, 5474.972625136849, 5475.616706830563, 5480.177973303957, 5490.0, 6286.339934306832, 6378.808635740936, 6451.580647257913, 6461.2892581816905, 6495.935040649628, 5293.364796224478, 6252.437280644764, 6272.40412160844, 6273.592216505913, 6293.622382657055, 6255.186825712628, 6395.776147834989, 6476.676166191577, 6510.283868774526, 6531.020346947806, 6220.129181914445, 6223.875522489434, 6232.875342493216, 6235.095911092957, 6235.127082208403, 5775.653460792366, 6073.392660734068, 6219.346968568416, 6234.096056071935, 6247.750089996349, 6001.189839371629, 6125.1424800527075, 6126.334466363025, 6205.379462053758, 6210.472109870531, 6175.814725558241, 6179.81460556184, 6185.41238582334, 6211.192544969125, 6228.0969259456215, 5224.399194092576, 6069.666168360783, 6143.416375444325, 6150.815475535741, 6158.291796443466, 6109.200087487409, 6158.137860699595, 6178.505719542336, 6211.689415529296, 6216.378362163929, 6087.208662873798, 6114.113453549122, 6125.908111378244, 6149.200603921461, 6154.1999540059505], "unit": "score", "name": "dojo.html", "value": 5736.76701658451}, {"lowerIsBetter": false, "replicates": [432.08398195824856, 446.2168893591746, 481.5184815184815, 580.4601720400028, 653.3042309939916, 32200.677993220062, 37882.621173788255, 38021.0, 38069.0, 38191.04522386938, 39171.0, 39282.0, 39852.40221396674, 39924.600753992454, 40005.0, 9364.531773411336, 9525.142737153656, 9578.892643618392, 9622.903770962306, 9628.711138665816, 9506.47714375709, 9736.269779766546, 9754.46350450725, 9757.609695612167, 9802.607895684165, 9707.514624268793, 9730.221582273436, 9737.95131024344, 9803.362781419184, 9827.410355378664, 9649.614015439374, 9702.27232957524, 9741.756456088619, 9761.316707830454, 9788.51057447132, 9537.618495260182, 9645.276604254708, 9673.984231655646, 9687.0, 9703.0, 37703.81148094269, 37770.622293776985, 37978.81010594957, 37995.81002094972, 38327.80836095801, 2986.522156454957, 3179.6184457865206, 3297.1921879139763, 3625.111847597329, 3910.081130934228, 21656.56686866254, 26263.21210363692, 28191.57712634312, 28261.71738282632, 28415.857920710263, 2508.109621084507, 2588.094167041539, 2724.4006318610072, 2751.6697996240378, 2860.985695071511, 424502.0, 424789.0, 426300.0, 426782.0, 426841.0, 56153.43846561564, 62022.68988655028, 62299.377006230265, 66078.0, 66621.66689166523, 62334.688326558986, 62573.37426625675, 62948.37051629517, 63230.0, 63241.051384228354, 16285.430009949832, 16331.101789401459, 16420.425285114965, 16434.506964791075, 16558.0, 12113.091518136174, 12409.503619855284, 12532.185407948455, 12548.12163148589, 12659.36703164838, 16727.414540491267, 17673.790776152982, 19981.100850461764, 20221.595568088556, 20226.0, 8607.655693772303, 8766.181876298459, 8804.32717783619, 8814.471131732116, 8841.55792210387, 919.9402038867452, 967.6226271754022, 1011.9392836429838, 1013.6249587652468, 1056.693558867935, 28048.158555243375, 29453.85273073621, 29491.410171796444, 29524.557131643043, 29863.104106876828, 1013.1995723378595, 1152.6772503698978, 1159.1596092832797, 1168.8480497535265, 1215.905684883612, 14920.70158596822, 14934.0, 14982.925085374722, 15198.544043678707, 15229.466968656045, 445884.0, 446799.5320046823, 447258.0, 454856.0, 456417.0, 56703.43296567064, 57038.714806425705, 57368.13947790786, 57480.71259643759, 57847.0, 1410.7249086428253, 1447.3993292783377, 1453.774664926938, 1454.3673502026652, 1469.8309694385282, 29375.55936660909, 29378.853105734335, 29486.820527178672, 29529.704702953553, 29742.0, 50679.23981140212, 50722.492775071776, 50821.0, 51049.48950510596, 51202.48797511977, 370082.0, 370352.0, 373030.0, 373446.1327693344, 374400.0, 30064.699353006188, 32453.0, 33343.99968000964, 33364.332713346084, 33453.33093338071, 39912.80043599763, 40907.59092409157, 41194.38208426936, 41686.58313416827, 41999.0, 34006.82996585001, 35089.473657895665, 35169.82415087908, 35324.0, 35514.467282990256, 35118.82440587781, 39965.0, 41400.79299603483, 42067.57932420637, 42260.36609450922, 38127.42808857925, 38332.59175194888, 38940.610593893696, 38951.6104838948, 39602.00994975149, 36304.27391452209, 37721.81139094287, 37853.621463785006, 38029.429558557196, 38634.0, 30220.11655278534, 30525.0, 30546.778128874597, 31046.379072417974, 31748.841255793574], "unit": "score", "name": "ext.html", "value": 19545.836335385415}, {"lowerIsBetter": false, "replicates": [318.7051976921348, 356.63266835159794, 358.6592736899944, 364.25328077441253, 367.2141616939748, 15325.233738313096, 18490.630187396262, 19050.42848714539, 19382.12780424881, 20024.89863057533, 18878.0, 18996.145173467226, 19209.519762005923, 19271.325503607375, 19382.321618743346, 4872.83052067503, 5549.77800887965, 5725.627834190765, 5856.590038697293, 5859.941400585983, 5216.66091704038, 5663.461971112738, 5674.0, 5691.117876729114, 5697.259356283698, 3824.3307421201316, 4347.869563913087, 5456.317960254968, 5480.0, 5853.765849366042, 5639.887202255973, 5809.0, 5824.621399609033, 5850.9414905851245, 5873.735681894325, 5465.0, 5474.315710536183, 5517.806876759334, 5565.693886836222, 5599.048161812501, 12766.170198937132, 13001.479940802357, 18132.728009079874, 22660.640361578193, 22824.08703651852, 1668.3889712599744, 2111.155537784883, 2112.2501511963187, 2185.2242453928784, 2340.9063637454483, 8543.487390756574, 9386.20217281532, 9409.682644429786, 9955.75110622233, 11626.476808543635, 1743.7733094697608, 1760.9735853962202, 1773.5211492896974, 1773.689604319239, 1806.9819301806945, 80588.98527536858, 82639.0, 88329.0, 90839.0, 92451.0, 11003.0, 11031.72420689473, 11139.665810025712, 11152.275102118336, 11170.497327620114, 13148.211107333591, 13181.538646147339, 13182.077254592086, 13210.009249306147, 13226.933865330611, 6827.7710012197285, 8409.873851892227, 8411.537365444838, 8447.915520844836, 8462.153784621612, 8467.53428561435, 8488.448250863674, 8496.447730897471, 8541.231289184003, 8578.699745509002, 4232.534421213664, 4312.482502099768, 4357.651387888961, 4371.0602220522105, 4379.255526560492, 1803.8545523592613, 1839.0804597701149, 1885.755950418997, 1899.8480121590517, 1920.5294702797903, 701.7684164225793, 732.8864026075967, 791.8851766493826, 801.7915342011119, 815.6745288905529, 15611.531654050397, 17764.289428422977, 18084.0, 19454.513637159183, 19692.50768730793, 815.9551224682581, 889.235257678396, 891.2869704236584, 954.379653225409, 955.7610597350663, 8206.712765053195, 8240.917590824134, 8410.873836892451, 9604.66383676568, 10530.0, 539447.0, 670919.0, 682608.0, 764704.0, 765286.0, 109250.0, 111521.44239278752, 113528.0, 120952.0, 125065.0, 1194.7729931313022, 1199.6341115959542, 1200.1179133337164, 1206.831043653889, 1217.6407959651924, 15279.61800954985, 18318.542036449195, 18485.35301264503, 18609.90695046516, 18931.0, 52446.0, 52602.47397526129, 53470.64263753905, 53606.73196633992, 54085.72957135189, 45596.0, 70721.64639176772, 72232.47186348452, 72868.90696639448, 74692.0, 6491.221053473613, 7278.871774874903, 7428.73999410018, 7548.245175482408, 7562.810929726581, 9840.803183936425, 9989.500524973577, 11315.264507806965, 11755.47100380502, 12100.939495302468, 8905.862592977768, 9964.0, 10588.629397971034, 10662.520186591777, 10724.785504290026, 9924.503774811375, 10276.640317589148, 10444.529996150039, 10446.112080472942, 10454.163666906781, 9568.712938611852, 10138.442385668564, 10717.624883129052, 11023.669289921316, 11059.778804424028, 7613.390928725578, 7662.540247585162, 7687.88468172989, 7807.180246074307, 7808.41436892224, 7991.800204994922, 9258.95370523143, 10517.684469465928, 10781.838272425763, 10866.185036122164], "unit": "score", "name": "jquery.html", "value": 8870.618753484121}, {"lowerIsBetter": false, "replicates": [1338.678717107894, 1540.9383624655015, 1710.3500669745495, 1862.115495139808, 1877.296013994752, 7906.881396779053, 8518.488890666564, 8701.73894783156, 8905.975812781531, 8937.865932011016, 8633.913660863389, 8681.565921703921, 8795.95602021989, 8803.20771130598, 8820.029796722372, 2448.730639629648, 2465.716442609096, 2474.2824580871525, 2478.281298423455, 2479.454520005605, 2428.465737537748, 2449.6570480132796, 2482.565551028563, 2496.1762618335997, 2505.5740524110943, 2188.3872515695552, 2413.8913748881255, 2439.292605144506, 2454.7299797022315, 2473.010795681733, 2432.2824766693866, 2442.0842184180933, 2449.424385269478, 2478.5414698280783, 2487.1916627096266, 2422.1522467136538, 2435.773932227584, 2449.167283123729, 2454.5336386086765, 2454.803615710739, 8755.781105472413, 8774.429662071945, 8814.911850881474, 8827.69103081389, 8835.293176545862, 5361.249425080492, 5471.671699698031, 5473.17902314652, 5487.122060470306, 5514.283143191399, 2841.559558268472, 3073.769467289962, 3631.2192878530977, 3710.461983012448, 3750.643688849555, 1043.9530221140067, 1087.7008822573775, 1090.9509072091776, 1107.8449017137607, 1110.36154211328, 11481.598144065001, 11623.070154387713, 11909.94045029778, 11954.222975506564, 11979.46092425843, 4881.926771098437, 4931.457539670633, 4957.429895562056, 4977.477364876709, 4985.626078044161, 8792.648294068165, 10143.543540540693, 10187.439690817077, 10271.74320641975, 10281.485925703684, 5417.133258678593, 5471.644343117685, 5477.507024367826, 5480.205370221295, 5489.176623506426, 4792.880177995508, 4852.441969173519, 4919.0, 4949.183384741477, 4975.651704380659, 3985.8206380712936, 3997.4603428537357, 4001.5398229203433, 4020.557738648746, 4032.7781971991235, 1219.969500762488, 1302.049503862167, 1303.4004357995238, 1318.723068155698, 1325.357201757147, 1092.1372116028408, 1095.222392101601, 1121.3440137519642, 1249.1256120715536, 1323.3052647360214, 8054.798630034296, 8107.14874938123, 8127.349812015024, 8144.918550814416, 8308.750737477885, 1023.7594165371132, 1143.2911594811271, 1161.953521859116, 1169.9590514331958, 1197.8562572491358, 6278.905816412757, 6310.716017779211, 6351.745930162834, 6354.936450635527, 6361.872762544724, 8839.734807955772, 10452.216083793746, 10533.210009249184, 10823.891761082446, 10867.239293249555, 10593.682189534326, 10754.784904302027, 10796.298240614335, 10823.404712740718, 10883.401412922207, 8156.836863262702, 8298.0, 8319.792005199797, 8322.750317490485, 8349.624266908004, 7717.421193410629, 7879.645415956181, 7910.2089791020435, 7989.960050199712, 7997.440179187401, 9203.815923681355, 9519.28605354615, 9598.712038638852, 9653.855192172263, 9734.221262299141, 9646.517674116125, 9998.900010999796, 10036.447995360326, 10078.0, 10158.136558392323, 7073.681684324115, 7212.819679508054, 7260.237675044044, 7272.127344718668, 7299.4160467163565, 6903.585784852925, 7991.001124859393, 8378.874316885374, 8411.074781774123, 8444.408891377545, 7754.6898124074405, 7880.936073629987, 7931.0, 7992.40056995716, 7995.480293780885, 7642.0, 7711.922880771345, 7756.379489640703, 7759.922400776146, 7903.644336004779, 7758.728444504415, 7782.727604533814, 7831.0, 7949.244821741925, 7956.482828616122, 7041.894371584533, 7193.208747037717, 7194.0, 7199.208087110309, 7234.0, 7228.891566626399, 7257.891131632924, 7296.124465064227, 7297.16082650502, 7301.306375894282], "unit": "score", "name": "mootools.html", "value": 4961.385514013239}, {"lowerIsBetter": false, "replicates": [324.92364294390813, 331.05483843626445, 331.9568456100707, 337.1924241441747, 338.05513589517295, 5987.0, 6869.896951545731, 6917.792466226015, 6919.654017299127, 7013.929860701392, 6817.590944543331, 6828.770821252173, 6847.349501797334, 6864.759733409319, 6926.341997510229, 5104.157813960701, 5115.514026167527, 5115.616328775357, 5128.640995130342, 5142.820001299955, 4800.735959522225, 5104.64267501275, 5115.718635475047, 5121.718305493197, 5130.127878260705, 4879.170541008019, 4888.755562221892, 4894.53501917319, 4909.263610458424, 4933.038057578774, 4271.273883439822, 4706.717596944194, 4857.198562237227, 4874.512548745132, 4888.144574699413, 3214.1964508872784, 3964.86122985697, 4002.899927501807, 4129.772862492562, 4182.665386769082, 6077.453029227391, 6534.771283005072, 6560.671966401661, 6588.736450541973, 6639.73441062357, 5027.698338099725, 5255.789768409259, 5380.461953804588, 5688.83378907323, 5859.707014649251, 7111.9332100184865, 7311.780646580611, 7313.817154571178, 7322.853542929165, 7351.375133113692, 4127.876163715094, 4653.0, 4661.114388266218, 4668.0, 4672.0, 6593.769218077392, 7380.188179300273, 7582.734604288823, 7793.805154871116, 7809.336206422404, 4598.126355992351, 4734.100520901018, 4737.763111844394, 4750.358701575243, 4773.809047638125, 4850.442199147073, 4858.975705121452, 4861.173600487926, 4867.3915760529935, 4870.488598697157, 4759.809607615726, 5822.621529600562, 5866.445391971131, 5866.6186697864505, 5881.0, 7392.815179620445, 7414.406847452191, 7414.962925185448, 7439.218882017419, 7456.552606843607, 1267.3283159925254, 1605.2054233154663, 1654.487108996191, 1654.5770637251953, 1665.991670041642, 1058.6771034834449, 1068.0814499530397, 1074.9197056957707, 1077.2513103393067, 1081.5727787523883, 6021.969890150521, 6290.930541807904, 6724.697388617524, 6729.22613899398, 6744.730210791611, 7636.8472630548185, 7656.655450504741, 7671.769846904602, 7689.077310722749, 7699.0, 6521.315261897527, 6769.458443324522, 6769.8646027079185, 6773.424258937947, 6774.187097548326, 3927.430522574211, 3977.1846771411792, 3977.980110099431, 3981.243563722883, 3981.8407263709128, 8005.719799806979, 8008.0, 8025.799355016171, 8046.517208967481, 8057.395695322874, 7919.168487308865, 7927.167647397056, 7954.363650907913, 8036.638351274207, 8064.919350806535, 7855.8821617675785, 8154.347652187929, 8165.2243036911395, 8177.632006559719, 8178.427510074238, 7788.532688038736, 7789.221077892165, 7808.063032436144, 7808.49244799109, 7883.014623172104, 6228.532860035606, 7357.411407087528, 7632.38940884739, 7657.502262352929, 7664.540127592362, 6538.8365290868105, 8144.67421303165, 8166.550839703873, 8180.0, 8187.79530511742, 4758.952410475851, 4800.255960326155, 4803.759812009455, 4803.783829727601, 4810.42274927011, 7433.368163706145, 7678.078630564368, 7741.7677469676, 7742.38060955111, 7807.492512986638, 7502.249775022454, 7517.0, 7520.09758828944, 7540.886886696813, 7541.509801862861, 7215.386692131227, 7501.512401693873, 7502.737404191045, 7503.624818758931, 7514.323710866049, 7313.012743279589, 7330.560166390033, 7357.2642735726, 7360.263973602597, 7376.704931802882, 7490.363319117936, 7502.512336698097, 7517.699292028257, 7534.4725869190825, 7538.0, 6292.0, 7135.500514963903, 7309.378702810321, 7338.633068346455, 7366.7053317866685], "unit": "score", "name": "prototype.html", "value": 5309.71121418349}, {"lowerIsBetter": false, "replicates": [672.663668165917, 673.219065883575, 692.1901375390793, 723.5043994863519, 743.3755645257983, 12383.44274507647, 14664.926675366622, 14852.777208341884, 15135.091894486339, 15160.39358425663, 13812.309384530783, 13828.792568111487, 13868.722625547483, 13896.791548126786, 13907.0, 681.788645519888, 834.9332053435726, 844.0420123160227, 852.40757673417, 857.6140736668524, 730.280673536566, 841.4908980067063, 845.3364109174299, 848.4909054567272, 859.0893652728097, 884.3765145572356, 907.7594437474074, 908.2688435809171, 908.900020997693, 911.7401540560942, 890.4523717913469, 895.5164211325877, 896.551724137931, 903.8282726282018, 906.0305473143673, 669.4142625202948, 676.5974245324024, 679.8334408070006, 680.6868840333452, 680.7821497120923, 14592.051516651383, 14837.406503739838, 14844.0, 14876.330565124486, 14906.70186596262, 12775.936120319338, 12889.226646401246, 13007.674808129777, 13255.337233138305, 13410.195388276637, 10304.0, 10344.844827327595, 10392.688219353431, 10413.095089341497, 10875.293105948089, 3453.4992426098074, 3503.737219708532, 3519.278547897675, 3526.6473352664784, 3543.450765131409, 79196.0, 79709.0, 81086.59456702738, 81544.0, 81640.59179704063, 8045.798855028671, 9563.378380405251, 9675.612975480903, 9967.700968970943, 10334.431606261578, 20969.68545471819, 21363.0, 21821.563568728536, 21837.563248734936, 21873.0, 7254.310840470147, 7455.030845989987, 7504.249575042561, 7717.151113377524, 7799.064112306446, 4050.2396989202557, 4083.7753923533896, 4136.420901073852, 4177.6866734995, 4313.309870420718, 3501.8074005929407, 3515.261795023023, 3538.7876727396438, 3540.8760693375607, 3560.0565850049757, 626.6208943589063, 642.4474951541764, 642.6979319719725, 644.2816259870211, 654.3227759269133, 501.6739119572307, 574.3280361976498, 582.7727186397224, 599.409581562161, 603.538293205698, 8327.125651806473, 8393.6222869971, 8412.369072319601, 8583.39916205872, 8636.309095272363, 506.6731957887142, 576.2537513919484, 605.7243954000919, 609.8536351275751, 637.5027478566725, 3891.3968334908136, 3963.385675220288, 3973.0861901762755, 4031.0, 4067.8372865085066, 90133.0, 91421.0, 91777.0822291782, 91778.0, 92456.53771731099, 62060.68969655123, 78899.0, 79161.0, 79410.6029469849, 80977.19022809814, 66111.66944165344, 68587.65706171437, 69911.0, 70352.94470582945, 71192.0, 8081.313088387553, 8108.067572229269, 8140.918590814016, 8241.0, 8291.212334828182, 48095.82370996869, 48694.0, 49328.01343973029, 49352.0, 49792.502074980235, 52733.209001864234, 57241.42758572527, 58401.0, 58971.82056358763, 59015.704921476834, 10889.0, 10983.286086404358, 11123.499442524944, 11346.978771910568, 11647.30116193031, 11908.273300371224, 12305.753884922431, 12309.507619695112, 12431.62705118848, 12804.29576373271, 11080.279781814157, 11090.833637495283, 11706.70733231676, 11773.52905883755, 12250.816237756262, 11265.317512919271, 11313.7737245253, 11329.71675708114, 11656.708582285512, 12284.81572776427, 10547.314424562379, 11249.0, 11325.660230193107, 11598.420078996185, 11618.6514404568, 9089.63641454361, 9131.863022054542, 9147.268218542633, 9427.528623568931, 10064.798704026025, 9119.863202052107, 9179.954100229455, 9486.573104210465, 9822.607095716377, 10138.03688649577], "unit": "score", "name": "yui.html", "value": 6818.180037969613}], "name": "dromaeo_css", "value": 7504.845141820187}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 115.0, 118.0, 118.0, 125.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.0}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 148.0, 158.0, 123.0, 140.0, 143.0, 123.0, 158.0, 155.0], "unit": "score", "name": "audio-beat-detection", "value": 142.6}, {"lowerIsBetter": true, "replicates": [193.0, 201.0, 197.0, 198.0, 205.0, 224.0, 199.0, 197.0, 201.0, 201.0], "unit": "score", "name": "audio-dft", "value": 201.6}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 73.0, 70.0, 141.0, 83.0, 90.0, 69.0, 63.0, 92.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [81.0, 87.0, 115.0, 79.0, 80.0, 81.0, 116.0, 82.0, 81.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 91.4}, {"lowerIsBetter": true, "replicates": [89.0, 127.0, 86.0, 96.0, 88.0, 93.0, 86.0, 104.0, 131.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 99.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 95.0, 97.0, 95.0, 95.0, 97.0, 98.0, 98.0], "unit": "score", "name": "imaging-darkroom", "value": 96.5}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 125.0, 143.0, 101.0, 90.0, 99.0, 87.0, 92.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 101.9}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 54.0, 58.0, 57.0, 56.0, 55.0, 64.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 63.0, 72.0, 72.0, 65.0, 66.0, 67.0, 67.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [90.0, 85.0, 90.0, 86.0, 84.0, 85.0, 88.0, 85.0, 110.0, 114.0], "unit": "score", "name": "stanford-crypto-aes", "value": 91.7}, {"lowerIsBetter": true, "replicates": [136.0, 129.0, 138.0, 127.0, 131.0, 117.0, 140.0, 135.0, 144.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.2}, {"lowerIsBetter": true, "replicates": [163.0, 178.0, 140.0, 143.0, 158.0, 138.0, 168.0, 145.0, 126.0, 179.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.8}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 66.0, 67.0, 69.0, 68.0, 63.0, 83.0, 71.0, 59.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1499.9}]} 05:34:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1499.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7504.85"}}} 05:34:33 INFO - Return code: 0 05:34:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:34:33 INFO - # TBPL SUCCESS # 05:34:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:34:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:34:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:34:33 INFO - 2016-02-09 05:34:33.736 screenresolution[1703:11068] starting screenresolution argv=screenresolution get 05:34:33 INFO - 2016-02-09 05:34:33.738 screenresolution[1703:11068] Display 0: 1600x1200x32@60 05:34:33 INFO - 2016-02-09 05:34:33.744 screenresolution[1704:11071] starting screenresolution argv=screenresolution list 05:34:33 INFO - Available Modes on Display 0 05:34:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:34:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:34:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:34:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:34:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:34:33 INFO - Intel Iris: 05:34:33 INFO - Chipset Model: Intel Iris 05:34:33 INFO - Type: GPU 05:34:33 INFO - Bus: Built-In 05:34:33 INFO - VRAM (Dynamic, Max): 1536 MB 05:34:33 INFO - Vendor: Intel (0x8086) 05:34:33 INFO - Device ID: 0x0a2e 05:34:33 INFO - Revision ID: 0x0009 05:34:33 INFO - Displays: 05:34:33 INFO - Display: 05:34:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:34:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:34:33 INFO - Display Serial Number: 1600x1200 60 05:34:33 INFO - Main Display: Yes 05:34:33 INFO - Mirror: Off 05:34:33 INFO - Online: Yes 05:34:33 INFO - Rotation: Supported 05:34:33 INFO - Return code: 0 05:34:33 INFO - Running post-action listener: _resource_record_post_action 05:34:33 INFO - Running post-run listener: _resource_record_post_run 05:34:35 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 34696704; Write bytes: 713924096; Read time: 358; Write time: 2066 05:34:35 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 406571520; Write bytes: 408814080; Read time: 30167; Write time: 766 05:34:35 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 32902656; Write bytes: 303819776; Read time: 338; Write time: 1299 05:34:35 INFO - Running post-run listener: _upload_blobber_files 05:34:35 INFO - Blob upload gear active. 05:34:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:34:35 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:34:35 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:34:35 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:34:35 INFO - (blobuploader) - INFO - Open directory for files ... 05:34:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:34:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:34:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:36 INFO - (blobuploader) - INFO - Done attempting. 05:34:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:34:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:34:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:37 INFO - (blobuploader) - INFO - Done attempting. 05:34:37 INFO - (blobuploader) - INFO - Iteration through files over. 05:34:37 INFO - Return code: 0 05:34:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:34:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:34:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c8fcf10ba430c684d14b16d22502e95a52a817ac1bdf5a1fa59ea874200af86fd3cc4e15758f03fd2beb10385df66f6500d1d46e725470606710c43ff114c43", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01cd066f8e7e5f1c515ff5ea3ea540be85ed44aeeb90b62c61a728c6867df0425ce6a0cb9406f700936770061b01fba0a74b91b4f0e0565631940355e3ba5bbb"} 05:34:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:34:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:34:37 INFO - Contents: 05:34:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c8fcf10ba430c684d14b16d22502e95a52a817ac1bdf5a1fa59ea874200af86fd3cc4e15758f03fd2beb10385df66f6500d1d46e725470606710c43ff114c43", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01cd066f8e7e5f1c515ff5ea3ea540be85ed44aeeb90b62c61a728c6867df0425ce6a0cb9406f700936770061b01fba0a74b91b4f0e0565631940355e3ba5bbb"} 05:34:37 INFO - Running post-run listener: copy_logs_to_upload_dir 05:34:37 INFO - Copying logs to upload dir... 05:34:37 INFO - mkdir: /builds/slave/test/build/upload/logs 05:34:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1293.878072 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-02-09 05:34:37.608553) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 05:34:37.612245) ========= 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.BAPRE82BYI/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.f31K0S4X6S/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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/Firefox/sha512/4c8fcf10ba430c684d14b16d22502e95a52a817ac1bdf5a1fa59ea874200af86fd3cc4e15758f03fd2beb10385df66f6500d1d46e725470606710c43ff114c43", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01cd066f8e7e5f1c515ff5ea3ea540be85ed44aeeb90b62c61a728c6867df0425ce6a0cb9406f700936770061b01fba0a74b91b4f0e0565631940355e3ba5bbb"} build_url:https://queue.taskcluster.net/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/SPGLEBIFQOu-z4v4mdhDqg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c8fcf10ba430c684d14b16d22502e95a52a817ac1bdf5a1fa59ea874200af86fd3cc4e15758f03fd2beb10385df66f6500d1d46e725470606710c43ff114c43", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01cd066f8e7e5f1c515ff5ea3ea540be85ed44aeeb90b62c61a728c6867df0425ce6a0cb9406f700936770061b01fba0a74b91b4f0e0565631940355e3ba5bbb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 05:34:37.638633) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:34:37.638973) ========= 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.BAPRE82BYI/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.f31K0S4X6S/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.005030 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:34:37.687695) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 05:34:37.688015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 05:34:37.688393) ========= ========= Total master_lag: 0.34 =========