builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0178 starttime: 1455101263.14 results: success (0) buildid: 20160208164823 builduid: 30a40c8c361641e58b7426d55eb90c1e revision: 49945e5fe79e6cf2b083f56fd49d917ca886db0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:43.143378) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:43.143817) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:43.144100) ========= 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.1qR9pvRQSO/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.tf2PjMuCka/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005466 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:43.167297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:43.167616) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:43.183951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:43.184325) ========= 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.1qR9pvRQSO/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.tf2PjMuCka/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005163 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:43.232006) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:43.232307) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:43.232675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:43.232948) ========= 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.1qR9pvRQSO/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.tf2PjMuCka/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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-10 02:47:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 39.8M=0s 2016-02-10 02:47:43 (39.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172531 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:43.420129) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:43.420451) ========= 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.1qR9pvRQSO/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.tf2PjMuCka/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.025323 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:43.469929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-10 02:47:43.470273) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 49945e5fe79e6cf2b083f56fd49d917ca886db0b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 49945e5fe79e6cf2b083f56fd49d917ca886db0b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1qR9pvRQSO/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.tf2PjMuCka/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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-10 02:47:43,548 truncating revision to first 12 chars 2016-02-10 02:47:43,549 Setting DEBUG logging. 2016-02-10 02:47:43,549 attempt 1/10 2016-02-10 02:47:43,549 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/49945e5fe79e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 02:47:45,610 unpacking tar archive at: fx-team-49945e5fe79e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.307494 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-10 02:47:45.793750) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:45.794140) ========= echo 49945e5fe79e6cf2b083f56fd49d917ca886db0b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'49945e5fe79e6cf2b083f56fd49d917ca886db0b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1qR9pvRQSO/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.tf2PjMuCka/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 49945e5fe79e6cf2b083f56fd49d917ca886db0b program finished with exit code 0 elapsedTime=0.005916 script_repo_revision: '49945e5fe79e6cf2b083f56fd49d917ca886db0b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:45.844705) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:45.845028) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:45.858490) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-10 02:47:45.858867) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1qR9pvRQSO/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.tf2PjMuCka/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 02:47:46 INFO - MultiFileLogger online at 20160210 02:47:46 in /builds/slave/test 02:47:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:47:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:47:46 INFO - {'append_to_log': False, 02:47:46 INFO - 'base_work_dir': '/builds/slave/test', 02:47:46 INFO - 'blob_upload_branch': 'Fx-Team', 02:47:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:47:46 INFO - 'branch': 'Fx-Team', 02:47:46 INFO - 'buildbot_json_path': 'buildprops.json', 02:47:46 INFO - 'config_files': ('talos/mac_config.py',), 02:47:46 INFO - 'default_actions': ('clobber', 02:47:46 INFO - 'read-buildbot-config', 02:47:46 INFO - 'download-and-extract', 02:47:46 INFO - 'populate-webroot', 02:47:46 INFO - 'create-virtualenv', 02:47:46 INFO - 'install', 02:47:46 INFO - 'run-tests'), 02:47:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:47:46 INFO - 'download_minidump_stackwalk': True, 02:47:46 INFO - 'download_symbols': 'ondemand', 02:47:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:47:46 INFO - 'tooltool.py': '/tools/tooltool.py', 02:47:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:47:46 INFO - '/tools/misc-python/virtualenv.py')}, 02:47:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:47:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:47:46 INFO - 'installer_path': 'installer.exe', 02:47:46 INFO - 'log_level': 'info', 02:47:46 INFO - 'log_name': 'talos', 02:47:46 INFO - 'log_to_console': True, 02:47:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:47:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:47:46 INFO - 'opt_config_files': (), 02:47:46 INFO - 'pip_index': False, 02:47:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:47:46 INFO - 'cmd': ('bash', 02:47:46 INFO - '-c', 02:47:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:47:46 INFO - 'enabled': True, 02:47:46 INFO - 'halt_on_failure': False, 02:47:46 INFO - 'name': 'check_screen_resolution'},), 02:47:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:47:46 INFO - 'cmd': ('bash', 02:47:46 INFO - '-c', 02:47:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:47:46 INFO - 'enabled': True, 02:47:46 INFO - 'halt_on_failure': False, 02:47:46 INFO - 'name': 'check_screen_resolution'},), 02:47:46 INFO - 'run_cmd_checks_enabled': True, 02:47:46 INFO - 'sps_profile': False, 02:47:46 INFO - 'sps_profile_interval': 0, 02:47:46 INFO - 'suite': 'dromaeojs', 02:47:46 INFO - 'system_bits': '32', 02:47:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:47:46 INFO - 'title': 't-yosemite-r7-0178', 02:47:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:47:46 INFO - 'use_talos_json': True, 02:47:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:47:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:47:46 INFO - 'work_dir': 'build'} 02:47:46 INFO - ##### 02:47:46 INFO - ##### Running clobber step. 02:47:46 INFO - ##### 02:47:46 INFO - Running pre-action listener: _resource_record_pre_action 02:47:46 INFO - Running main action method: clobber 02:47:46 INFO - rmtree: /builds/slave/test/build 02:47:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:47:47 INFO - Running post-action listener: _resource_record_post_action 02:47:47 INFO - ##### 02:47:47 INFO - ##### Running read-buildbot-config step. 02:47:47 INFO - ##### 02:47:47 INFO - Running pre-action listener: _resource_record_pre_action 02:47:47 INFO - Running main action method: read_buildbot_config 02:47:47 INFO - Using buildbot properties: 02:47:47 INFO - { 02:47:47 INFO - "project": "", 02:47:47 INFO - "product": "firefox", 02:47:47 INFO - "script_repo_revision": "production", 02:47:47 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:47:47 INFO - "repository": "", 02:47:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:47:47 INFO - "buildid": "20160208164823", 02:47:47 INFO - "pgo_build": "False", 02:47:47 INFO - "basedir": "/builds/slave/test", 02:47:47 INFO - "buildnumber": 319, 02:47:47 INFO - "slavename": "t-yosemite-r7-0178", 02:47:47 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:47:47 INFO - "platform": "yosemite_r7", 02:47:47 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:47:47 INFO - "branch": "fx-team", 02:47:47 INFO - "repo_path": "integration/fx-team", 02:47:47 INFO - "revision": "49945e5fe79e6cf2b083f56fd49d917ca886db0b", 02:47:47 INFO - "stage_platform": "macosx64", 02:47:47 INFO - "builduid": "30a40c8c361641e58b7426d55eb90c1e", 02:47:47 INFO - "slavebuilddir": "test" 02:47:47 INFO - } 02:47:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 02:47:47 INFO - Running post-action listener: _resource_record_post_action 02:47:47 INFO - ##### 02:47:47 INFO - ##### Running download-and-extract step. 02:47:47 INFO - ##### 02:47:47 INFO - Running pre-action listener: _resource_record_pre_action 02:47:47 INFO - Running main action method: download_and_extract 02:47:47 INFO - mkdir: /builds/slave/test/build/tests 02:47: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')]} 02:47:47 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:47:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json 02:47:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json 02:47:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:47:49 INFO - Downloaded 1277 bytes. 02:47:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:47:49 INFO - Using the following test package requirements: 02:47:49 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:47:49 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:47:49 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 02:47:49 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:47:49 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 02:47:49 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:47:49 INFO - u'jsshell-mac.zip'], 02:47:49 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:47:49 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 02:47:49 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:47:49 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:47:49 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 02:47:49 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:47:49 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 02:47:49 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:47:49 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 02:47:49 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:47:49 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:47:49 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 02:47:49 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:47:49 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')]} 02:47:49 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:47:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:47:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:47:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:47:51 INFO - Downloaded 17753849 bytes. 02:47:51 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'] 02:47:51 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 02:47:54 INFO - Return code: 0 02:47:54 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 02:47:54 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')]} 02:47:54 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:47:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:47:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:47:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:47:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:47:55 INFO - Downloaded 17753849 bytes. 02:47:55 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'] 02:47:55 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 02:47:59 INFO - Return code: 0 02:47:59 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')]} 02:47:59 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:47:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:47:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:47:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:47:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:00 INFO - Downloaded 10706547 bytes. 02:48:00 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'] 02:48:00 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 02:48:00 INFO - Return code: 0 02:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:00 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:48:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:48:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:48:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 02:48:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:04 INFO - Downloaded 111836573 bytes. 02:48:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:48:04 INFO - mkdir: /builds/slave/test/properties 02:48:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:04 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:04 INFO - Contents: 02:48:04 INFO - build_url:https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:48:05 INFO - Running post-action listener: _resource_record_post_action 02:48:05 INFO - Running post-action listener: set_extra_try_arguments 02:48:05 INFO - ##### 02:48:05 INFO - ##### Running populate-webroot step. 02:48:05 INFO - ##### 02:48:05 INFO - Running pre-action listener: _resource_record_pre_action 02:48:05 INFO - Running main action method: populate_webroot 02:48:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:05 INFO - '--tppagecycles', 02:48:05 INFO - '7'], 02:48:05 INFO - 'tests': ['tsvgm']}}, 02:48:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:48:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:48:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:48:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:48:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:48:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:05 INFO - 'talos_options': ['--e10s'], 02:48:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:05 INFO - 'tests': ['damp', 'tps']}, 02:48:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:05 INFO - 'talos_options': ['--e10s'], 02:48:05 INFO - 'tests': ['damp', 'tps']}, 02:48:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:48:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:05 INFO - 'other': {'tests': ['a11yr', 02:48:05 INFO - 'ts_paint', 02:48:05 INFO - 'tpaint', 02:48:05 INFO - 'sessionrestore', 02:48:05 INFO - 'sessionrestore_no_auto_restore']}, 02:48:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:48:05 INFO - 'tests': ['a11yr', 02:48:05 INFO - 'ts_paint', 02:48:05 INFO - 'tpaint', 02:48:05 INFO - 'sessionrestore', 02:48:05 INFO - 'sessionrestore_no_auto_restore']}, 02:48:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:48:05 INFO - 'tests': ['a11yr', 02:48:05 INFO - 'ts_paint', 02:48:05 INFO - 'tpaint', 02:48:05 INFO - 'sessionrestore', 02:48:05 INFO - 'sessionrestore_no_auto_restore']}, 02:48:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:48:05 INFO - 'tests': ['a11yr', 02:48:05 INFO - 'ts_paint', 02:48:05 INFO - 'tpaint', 02:48:05 INFO - 'sessionrestore', 02:48:05 INFO - 'sessionrestore_no_auto_restore']}, 02:48:05 INFO - 'other_l64': {'tests': ['a11yr', 02:48:05 INFO - 'ts_paint', 02:48:05 INFO - 'tpaint', 02:48:05 INFO - 'sessionrestore', 02:48:05 INFO - 'sessionrestore_no_auto_restore']}, 02:48:05 INFO - 'other_nol64': {'tests': ['a11yr', 02:48:05 INFO - 'ts_paint', 02:48:05 INFO - 'tpaint', 02:48:05 INFO - 'sessionrestore', 02:48:05 INFO - 'sessionrestore_no_auto_restore']}, 02:48:05 INFO - 'svgr': {'tests': ['tsvgx', 02:48:05 INFO - 'tsvgr_opacity', 02:48:05 INFO - 'tart', 02:48:05 INFO - 'tscrollx', 02:48:05 INFO - 'cart']}, 02:48:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:48:05 INFO - 'tests': ['tsvgx', 02:48:05 INFO - 'tsvgr_opacity', 02:48:05 INFO - 'tart', 02:48:05 INFO - 'tscrollx', 02:48:05 INFO - 'cart']}, 02:48:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:05 INFO - 'tests': ['tp5o']}, 02:48:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:05 INFO - 'talos_options': ['--e10s'], 02:48:05 INFO - 'tests': ['tp5o']}, 02:48:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:05 INFO - 'talos_options': ['--xperf_path', 02:48:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:05 INFO - 'tests': ['tp5n']}, 02:48:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:05 INFO - 'talos_options': ['--e10s', 02:48:05 INFO - '--xperf_path', 02:48:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:05 INFO - 'tests': ['tp5n']}}, 02:48:05 INFO - 'talos.zip': {'path': '', 02:48:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:05 INFO - Running post-action listener: _resource_record_post_action 02:48:05 INFO - ##### 02:48:05 INFO - ##### Running create-virtualenv step. 02:48:05 INFO - ##### 02:48:05 INFO - Running pre-action listener: _resource_record_pre_action 02:48:05 INFO - Running main action method: create_virtualenv 02:48:05 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48:05 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 02:48:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:05 INFO - Using real prefix '/tools/python27' 02:48:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:06 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:08 INFO - Installing pip.................done. 02:48:08 INFO - Return code: 0 02:48:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48:08 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')]} 02:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:08 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')]} 02:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:08 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 0x104c43a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c4b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd73b58c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae7d30>, '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 0x10490bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adeb20>, '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.1qR9pvRQSO/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.tf2PjMuCka/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 02:48:08 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 02:48:08 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 02:48:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qR9pvRQSO/Render', 02:48:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:08 INFO - 'HOME': '/Users/cltbld', 02:48:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:08 INFO - 'LOGNAME': 'cltbld', 02:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:08 INFO - 'MOZ_NO_REMOTE': '1', 02:48:08 INFO - 'NO_EM_RESTART': '1', 02:48:08 INFO - 'PAGER': '/bin/cat', 02:48:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:08 INFO - 'PWD': '/builds/slave/test', 02:48:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:08 INFO - 'SHELL': '/bin/bash', 02:48:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tf2PjMuCka/Listeners', 02:48:08 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 02:48:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:08 INFO - 'USER': 'cltbld', 02:48:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:08 INFO - 'XPC_FLAGS': '0x0', 02:48:08 INFO - 'XPC_SERVICE_NAME': '0', 02:48:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:09 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 02:48:09 INFO - Cleaning up... 02:48:09 INFO - Return code: 0 02:48:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:09 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 0x104c43a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c4b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd73b58c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae7d30>, '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 0x10490bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adeb20>, '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.1qR9pvRQSO/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.tf2PjMuCka/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 02:48:09 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 02:48:09 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 02:48:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qR9pvRQSO/Render', 02:48:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:09 INFO - 'HOME': '/Users/cltbld', 02:48:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:09 INFO - 'LOGNAME': 'cltbld', 02:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:09 INFO - 'MOZ_NO_REMOTE': '1', 02:48:09 INFO - 'NO_EM_RESTART': '1', 02:48:09 INFO - 'PAGER': '/bin/cat', 02:48:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:09 INFO - 'PWD': '/builds/slave/test', 02:48:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:09 INFO - 'SHELL': '/bin/bash', 02:48:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tf2PjMuCka/Listeners', 02:48:09 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 02:48:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:09 INFO - 'USER': 'cltbld', 02:48:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:09 INFO - 'XPC_FLAGS': '0x0', 02:48:09 INFO - 'XPC_SERVICE_NAME': '0', 02:48:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:09 INFO - Downloading/unpacking psutil>=0.7.1 02:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:48:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:12 INFO - Installing collected packages: psutil 02:48:12 INFO - Running setup.py install for psutil 02:48:12 INFO - building 'psutil._psutil_osx' extension 02:48:12 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 02:48:13 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 02:48:13 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 02:48:13 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 02:48:13 INFO - building 'psutil._psutil_posix' extension 02:48:13 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 02:48:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:48:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:48:13 INFO - ^ 02:48:13 INFO - 1 warning generated. 02:48:13 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 02:48:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:13 INFO - Successfully installed psutil 02:48:13 INFO - Cleaning up... 02:48:13 INFO - Return code: 0 02:48:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104c43a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c4b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd73b58c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae7d30>, '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 0x10490bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adeb20>, '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.1qR9pvRQSO/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.tf2PjMuCka/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 02:48:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:48:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qR9pvRQSO/Render', 02:48:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:13 INFO - 'HOME': '/Users/cltbld', 02:48:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:13 INFO - 'LOGNAME': 'cltbld', 02:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:13 INFO - 'MOZ_NO_REMOTE': '1', 02:48:13 INFO - 'NO_EM_RESTART': '1', 02:48:13 INFO - 'PAGER': '/bin/cat', 02:48:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:13 INFO - 'PWD': '/builds/slave/test', 02:48:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:13 INFO - 'SHELL': '/bin/bash', 02:48:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tf2PjMuCka/Listeners', 02:48:13 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 02:48:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:13 INFO - 'USER': 'cltbld', 02:48:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:13 INFO - 'XPC_FLAGS': '0x0', 02:48:13 INFO - 'XPC_SERVICE_NAME': '0', 02:48:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:48:16 INFO - Installing collected packages: mozsystemmonitor 02:48:16 INFO - Running setup.py install for mozsystemmonitor 02:48:16 INFO - Successfully installed mozsystemmonitor 02:48:16 INFO - Cleaning up... 02:48:16 INFO - Return code: 0 02:48:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104c43a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c4b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd73b58c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae7d30>, '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 0x10490bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adeb20>, '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.1qR9pvRQSO/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.tf2PjMuCka/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 02:48:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:48:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:48:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qR9pvRQSO/Render', 02:48:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:16 INFO - 'HOME': '/Users/cltbld', 02:48:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:16 INFO - 'LOGNAME': 'cltbld', 02:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:16 INFO - 'MOZ_NO_REMOTE': '1', 02:48:16 INFO - 'NO_EM_RESTART': '1', 02:48:16 INFO - 'PAGER': '/bin/cat', 02:48:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:16 INFO - 'PWD': '/builds/slave/test', 02:48:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:16 INFO - 'SHELL': '/bin/bash', 02:48:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tf2PjMuCka/Listeners', 02:48:16 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 02:48:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:16 INFO - 'USER': 'cltbld', 02:48:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:16 INFO - 'XPC_FLAGS': '0x0', 02:48:16 INFO - 'XPC_SERVICE_NAME': '0', 02:48:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:16 INFO - Downloading/unpacking blobuploader==1.2.4 02:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:19 INFO - Downloading blobuploader-1.2.4.tar.gz 02:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:48:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:48:19 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 02:48:19 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 02:48:19 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 02:48:19 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 02:48:19 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 02:48:19 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 02:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:48:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:48:19 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 02:48:19 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 02:48:19 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 02:48:19 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 02:48:19 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 02:48:19 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 02:48:20 INFO - Downloading docopt-0.6.1.tar.gz 02:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:48:20 INFO - Installing collected packages: blobuploader, requests, docopt 02:48:20 INFO - Running setup.py install for blobuploader 02:48:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:48:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:48:20 INFO - Running setup.py install for requests 02:48:20 INFO - Running setup.py install for docopt 02:48:21 INFO - Successfully installed blobuploader requests docopt 02:48:21 INFO - Cleaning up... 02:48:21 INFO - Return code: 0 02:48:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:21 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 0x104c43a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c4b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd73b58c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae7d30>, '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 0x10490bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adeb20>, '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.1qR9pvRQSO/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.tf2PjMuCka/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 02:48:21 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 02:48:21 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 02:48:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qR9pvRQSO/Render', 02:48:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:21 INFO - 'HOME': '/Users/cltbld', 02:48:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:21 INFO - 'LOGNAME': 'cltbld', 02:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:21 INFO - 'MOZ_NO_REMOTE': '1', 02:48:21 INFO - 'NO_EM_RESTART': '1', 02:48:21 INFO - 'PAGER': '/bin/cat', 02:48:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:21 INFO - 'PWD': '/builds/slave/test', 02:48:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:21 INFO - 'SHELL': '/bin/bash', 02:48:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tf2PjMuCka/Listeners', 02:48:21 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 02:48:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:21 INFO - 'USER': 'cltbld', 02:48:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:21 INFO - 'XPC_FLAGS': '0x0', 02:48:21 INFO - 'XPC_SERVICE_NAME': '0', 02:48:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-39KoTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-NnVcMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-X3iw9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-UioQ73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-hhMRL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-fGrOQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-oD7_P0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-3I0BIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ntSSIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-DLcMoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ef5pnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-tJrazF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-HHAkFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-UzvSuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Lj3wSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:23 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-dUupqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:23 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-hbWZNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:48:23 INFO - Running setup.py install for manifestparser 02:48:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:48:23 INFO - Running setup.py install for mozcrash 02:48:23 INFO - Running setup.py install for mozdebug 02:48:23 INFO - Running setup.py install for mozdevice 02:48:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:48:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:48:23 INFO - Running setup.py install for mozfile 02:48:23 INFO - Running setup.py install for mozhttpd 02:48:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:48:24 INFO - Running setup.py install for mozinfo 02:48:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:48:24 INFO - Running setup.py install for mozInstall 02:48:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:48:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:48:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:48:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:48:24 INFO - Running setup.py install for mozleak 02:48:24 INFO - Running setup.py install for mozlog 02:48:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:48:24 INFO - Running setup.py install for moznetwork 02:48:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:48:24 INFO - Running setup.py install for mozprocess 02:48:25 INFO - Running setup.py install for mozprofile 02:48:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:48:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:48:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:48:25 INFO - Running setup.py install for mozrunner 02:48:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:48:25 INFO - Running setup.py install for mozscreenshot 02:48:25 INFO - Running setup.py install for moztest 02:48:25 INFO - Running setup.py install for mozversion 02:48:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:48:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:48:25 INFO - Cleaning up... 02:48:25 INFO - Return code: 0 02:48:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:25 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 0x104c43a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c4b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd73b58c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae7d30>, '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 0x10490bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adeb20>, '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.1qR9pvRQSO/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.tf2PjMuCka/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 02:48:25 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 02:48:25 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 02:48:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qR9pvRQSO/Render', 02:48:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:25 INFO - 'HOME': '/Users/cltbld', 02:48:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:25 INFO - 'LOGNAME': 'cltbld', 02:48:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:25 INFO - 'MOZ_NO_REMOTE': '1', 02:48:25 INFO - 'NO_EM_RESTART': '1', 02:48:25 INFO - 'PAGER': '/bin/cat', 02:48:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:25 INFO - 'PWD': '/builds/slave/test', 02:48:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:25 INFO - 'SHELL': '/bin/bash', 02:48:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tf2PjMuCka/Listeners', 02:48:25 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 02:48:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:25 INFO - 'USER': 'cltbld', 02:48:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:25 INFO - 'XPC_FLAGS': '0x0', 02:48:25 INFO - 'XPC_SERVICE_NAME': '0', 02:48:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-pAthwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:26 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)) 02:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-VzAOze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:26 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)) 02:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-fLAuJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:26 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)) 02:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-F6wyVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:26 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)) 02:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ckGGGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:26 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)) 02:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-VnqjwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:26 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)) 02:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-nM37gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:26 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)) 02:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-rlkdB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:26 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)) 02:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-uI9liI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:27 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)) 02:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-I0EQlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:27 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)) 02:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ZpzXq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:27 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)) 02:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Y0fY7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:27 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)) 02:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-MfMq1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:27 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)) 02:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-QD8b2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:27 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)) 02:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-BGSZAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:27 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)) 02:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-4OkLvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:27 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)) 02:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-k_5taT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:27 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)) 02:48:27 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)) 02:48:27 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)) 02:48:27 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)) 02:48:27 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)) 02:48:27 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)) 02:48:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:30 INFO - Downloading blessings-1.6.tar.gz 02:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:48:30 INFO - Installing collected packages: blessings 02:48:30 INFO - Running setup.py install for blessings 02:48:30 INFO - Successfully installed blessings 02:48:30 INFO - Cleaning up... 02:48:30 INFO - Return code: 0 02:48:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:48:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:30 INFO - Reading from file tmpfile_stdout 02:48:30 INFO - Current package versions: 02:48:30 INFO - blessings == 1.6 02:48:30 INFO - blobuploader == 1.2.4 02:48:30 INFO - docopt == 0.6.1 02:48:30 INFO - manifestparser == 1.1 02:48:30 INFO - mozInstall == 1.12 02:48:30 INFO - mozcrash == 0.16 02:48:30 INFO - mozdebug == 0.1 02:48:30 INFO - mozdevice == 0.48 02:48:30 INFO - mozfile == 1.2 02:48:30 INFO - mozhttpd == 0.7 02:48:30 INFO - mozinfo == 0.9 02:48:30 INFO - mozleak == 0.1 02:48:30 INFO - mozlog == 3.1 02:48:30 INFO - moznetwork == 0.27 02:48:30 INFO - mozprocess == 0.22 02:48:30 INFO - mozprofile == 0.28 02:48:30 INFO - mozrunner == 6.11 02:48:30 INFO - mozscreenshot == 0.1 02:48:30 INFO - mozsystemmonitor == 0.0 02:48:30 INFO - moztest == 0.7 02:48:30 INFO - mozversion == 1.4 02:48:30 INFO - psutil == 3.1.1 02:48:30 INFO - requests == 1.2.3 02:48:30 INFO - wsgiref == 0.1.2 02:48:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:30 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')]} 02:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:30 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')]} 02:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:30 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 0x104c43a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c4b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd73b58c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae7d30>, '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 0x10490bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adeb20>, '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.1qR9pvRQSO/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.tf2PjMuCka/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 02:48:30 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 02:48:30 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 02:48:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qR9pvRQSO/Render', 02:48:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:30 INFO - 'HOME': '/Users/cltbld', 02:48:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:30 INFO - 'LOGNAME': 'cltbld', 02:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:30 INFO - 'MOZ_NO_REMOTE': '1', 02:48:30 INFO - 'NO_EM_RESTART': '1', 02:48:30 INFO - 'PAGER': '/bin/cat', 02:48:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:30 INFO - 'PWD': '/builds/slave/test', 02:48:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:30 INFO - 'SHELL': '/bin/bash', 02:48:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tf2PjMuCka/Listeners', 02:48:30 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 02:48:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:30 INFO - 'USER': 'cltbld', 02:48:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:30 INFO - 'XPC_FLAGS': '0x0', 02:48:30 INFO - 'XPC_SERVICE_NAME': '0', 02:48:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:31 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)) 02:48:31 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)) 02:48:31 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)) 02:48:31 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)) 02:48:31 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)) 02:48:31 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)) 02:48:31 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)) 02:48:31 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)) 02:48:31 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)) 02:48:31 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)) 02:48:31 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)) 02:48:31 INFO - Cleaning up... 02:48:31 INFO - Return code: 0 02:48:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:48:31 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')]} 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:31 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')]} 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:31 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 0x104c43a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c4b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd73b58c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae7d30>, '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 0x10490bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adeb20>, '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.1qR9pvRQSO/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.tf2PjMuCka/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 02:48:31 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 02:48:31 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 02:48:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qR9pvRQSO/Render', 02:48:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:31 INFO - 'HOME': '/Users/cltbld', 02:48:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:31 INFO - 'LOGNAME': 'cltbld', 02:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:31 INFO - 'MOZ_NO_REMOTE': '1', 02:48:31 INFO - 'NO_EM_RESTART': '1', 02:48:31 INFO - 'PAGER': '/bin/cat', 02:48:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:31 INFO - 'PWD': '/builds/slave/test', 02:48:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:31 INFO - 'SHELL': '/bin/bash', 02:48:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tf2PjMuCka/Listeners', 02:48:31 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 02:48:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:31 INFO - 'USER': 'cltbld', 02:48:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:31 INFO - 'XPC_FLAGS': '0x0', 02:48:31 INFO - 'XPC_SERVICE_NAME': '0', 02:48:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:31 INFO - Downloading/unpacking jsonschema 02:48:31 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 02:48:31 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 02:48:31 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 02:48:31 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 02:48:31 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 02:48:31 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 02:48:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:48:33 INFO - Downloading/unpacking functools32 (from jsonschema) 02:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:34 INFO - Downloading functools32-3.2.3-2.tar.gz 02:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:48:34 INFO - warning: no files found matching '*.txt' 02:48:34 INFO - no previously-included directories found matching 'build' 02:48:34 INFO - no previously-included directories found matching 'dist' 02:48:34 INFO - no previously-included directories found matching '.git*' 02:48:34 INFO - Installing collected packages: jsonschema, functools32 02:48:34 INFO - Running setup.py install for functools32 02:48:34 INFO - warning: no files found matching '*.txt' 02:48:34 INFO - no previously-included directories found matching 'build' 02:48:34 INFO - no previously-included directories found matching 'dist' 02:48:34 INFO - no previously-included directories found matching '.git*' 02:48:34 INFO - Successfully installed jsonschema functools32 02:48:34 INFO - Cleaning up... 02:48:34 INFO - Return code: 0 02:48:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:34 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 0x104c43a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c4b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd73b58c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae7d30>, '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 0x10490bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adeb20>, '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.1qR9pvRQSO/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.tf2PjMuCka/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 02:48:34 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 02:48:34 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 02:48:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qR9pvRQSO/Render', 02:48:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:34 INFO - 'HOME': '/Users/cltbld', 02:48:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:34 INFO - 'LOGNAME': 'cltbld', 02:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:34 INFO - 'MOZ_NO_REMOTE': '1', 02:48:34 INFO - 'NO_EM_RESTART': '1', 02:48:34 INFO - 'PAGER': '/bin/cat', 02:48:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:34 INFO - 'PWD': '/builds/slave/test', 02:48:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:34 INFO - 'SHELL': '/bin/bash', 02:48:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tf2PjMuCka/Listeners', 02:48:34 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 02:48:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:34 INFO - 'USER': 'cltbld', 02:48:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:34 INFO - 'XPC_FLAGS': '0x0', 02:48:34 INFO - 'XPC_SERVICE_NAME': '0', 02:48:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:34 INFO - Downloading/unpacking flake8 02:48:34 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 02:48:34 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 02:48:34 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 02:48:34 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 02:48:34 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 02:48:34 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 02:48:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:48:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:48:37 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 02:48:37 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 02:48:37 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 02:48:37 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 02:48:37 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 02:48:37 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 02:48:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:48:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:48:37 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 02:48:37 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 02:48:37 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 02:48:37 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 02:48:37 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 02:48:37 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 02:48:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:48:37 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 02:48:37 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 02:48:37 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 02:48:37 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 02:48:37 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 02:48:37 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 02:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:48:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:48:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:48:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:48:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:48:38 INFO - no previously-included directories found matching 'docs/_build' 02:48:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:48:38 INFO - Running setup.py install for pep8 02:48:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:48:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:48:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:48:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:48:38 INFO - no previously-included directories found matching 'docs/_build' 02:48:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:48:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:48:38 INFO - Cleaning up... 02:48:38 INFO - Return code: 0 02:48:38 INFO - Running post-action listener: _resource_record_post_action 02:48:38 INFO - Running post-action listener: _start_resource_monitoring 02:48:38 INFO - Starting resource monitoring. 02:48:38 INFO - ##### 02:48:38 INFO - ##### Running install step. 02:48:38 INFO - ##### 02:48:38 INFO - Running pre-action listener: _resource_record_pre_action 02:48:38 INFO - Running main action method: install 02:48:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:38 INFO - Reading from file tmpfile_stdout 02:48:38 INFO - Detecting whether we're running mozinstall >=1.0... 02:48:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:48:39 INFO - Reading from file tmpfile_stdout 02:48:39 INFO - Output received: 02:48:39 INFO - Usage: mozinstall [options] installer 02:48:39 INFO - Options: 02:48:39 INFO - -h, --help show this help message and exit 02:48:39 INFO - -d DEST, --destination=DEST 02:48:39 INFO - Directory to install application into. [default: 02:48:39 INFO - "/builds/slave/test"] 02:48:39 INFO - --app=APP Application being installed. [default: firefox] 02:48:39 INFO - mkdir: /builds/slave/test/build/application 02:48:39 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'] 02:48:39 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 02:49:13 INFO - Reading from file tmpfile_stdout 02:49:13 INFO - Output received: 02:49:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:49:13 INFO - Running post-action listener: _resource_record_post_action 02:49:13 INFO - ##### 02:49:13 INFO - ##### Running run-tests step. 02:49:13 INFO - ##### 02:49:13 INFO - Running pre-action listener: _resource_record_pre_action 02:49:13 INFO - Running main action method: run_tests 02:49:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:49:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:49:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:49:13 INFO - 2016-02-10 02:49:13.329 screenresolution[1650:7846] starting screenresolution argv=screenresolution get 02:49:13 INFO - 2016-02-10 02:49:13.331 screenresolution[1650:7846] Display 0: 1600x1200x32@60 02:49:13 INFO - 2016-02-10 02:49:13.337 screenresolution[1651:7848] starting screenresolution argv=screenresolution list 02:49:13 INFO - Available Modes on Display 0 02:49:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:49:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:49:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:49:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:49:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:49:13 INFO - Intel Iris: 02:49:13 INFO - Chipset Model: Intel Iris 02:49:13 INFO - Type: GPU 02:49:13 INFO - Bus: Built-In 02:49:13 INFO - VRAM (Dynamic, Max): 1536 MB 02:49:13 INFO - Vendor: Intel (0x8086) 02:49:13 INFO - Device ID: 0x0a2e 02:49:13 INFO - Revision ID: 0x0009 02:49:13 INFO - Displays: 02:49:13 INFO - Display: 02:49:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:49:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:49:13 INFO - Display Serial Number: 1600x1200 60 02:49:13 INFO - Main Display: Yes 02:49:13 INFO - Mirror: Off 02:49:13 INFO - Online: Yes 02:49:13 INFO - Rotation: Supported 02:49:13 INFO - Return code: 0 02:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:13 INFO - Python 2.7.3 02:49:13 INFO - Return code: 0 02:49:13 INFO - grabbing minidump binary from tooltool 02:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:13 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 0x104ae7d30>, '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 0x10490bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49:13 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 02:49:13 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 02:49:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:13 INFO - Return code: 0 02:49:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:49:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:49:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:49:14 INFO - Return code: 0 02:49:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:49:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0178 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:49:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qR9pvRQSO/Render', 02:49:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:14 INFO - 'HOME': '/Users/cltbld', 02:49:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:14 INFO - 'LOGNAME': 'cltbld', 02:49:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:49:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:14 INFO - 'MOZ_NO_REMOTE': '1', 02:49:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:49:14 INFO - 'NO_EM_RESTART': '1', 02:49:14 INFO - 'PAGER': '/bin/cat', 02:49:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:14 INFO - 'PWD': '/builds/slave/test', 02:49:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:49:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:14 INFO - 'SHELL': '/bin/bash', 02:49:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tf2PjMuCka/Listeners', 02:49:14 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 02:49:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:14 INFO - 'USER': 'cltbld', 02:49:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:14 INFO - 'XPC_FLAGS': '0x0', 02:49:14 INFO - 'XPC_SERVICE_NAME': '0', 02:49:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:49:15 INFO - mozversion application_buildid: 20160208164823 02:49:15 INFO - mozversion application_changeset: 49945e5fe79e6cf2b083f56fd49d917ca886db0b 02:49:15 INFO - mozversion application_display_name: Nightly 02:49:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:15 INFO - mozversion application_name: Firefox 02:49:15 INFO - mozversion application_remotingname: firefox 02:49:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:49:15 INFO - mozversion application_vendor: Mozilla 02:49:15 INFO - mozversion application_version: 47.0a1 02:49:15 INFO - mozversion platform_buildid: 20160208164823 02:49:15 INFO - mozversion platform_changeset: 49945e5fe79e6cf2b083f56fd49d917ca886db0b 02:49:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:49:15 INFO - mozversion platform_version: 47.0a1 02:49:15 INFO - using testdate: 1455101355 02:49:15 INFO - actual date: 1455101355 02:49:15 INFO - starting webserver on 'localhost:49290' 02:49:15 INFO - SUITE-START | Running 2 tests 02:49:15 INFO - TEST-START | dromaeo_css 02:49:15 INFO - operating with platform_type : mac_ 02:49:15 INFO - Initialising browser for dromaeo_css test... 02:49:15 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpcTPlqB/profile http://localhost:49290/getInfo.html) 02:49:17 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 02:49:17 INFO - PROCESS | 1669 | colorDepth:24 02:49:17 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 02:49:17 INFO - PROCESS | 1669 | __metrics 02:49:17 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:49:17 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:49:18 INFO - TEST-INFO | 1669: exit 0 02:49:18 INFO - Browser initialized. 02:49:18 INFO - Running cycle 1/1 for dromaeo_css test... 02:49:18 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpcTPlqB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:30 INFO - PROCESS | 1672 | RSS: Main: 245563392 02:49:30 INFO - PROCESS | 1672 | 02:50:21 INFO - PROCESS | 1672 | 1455101421379 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] 02:52:31 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49290/tests/dromaeo/cssquery-ext.html) 02:52:33 INFO - PROCESS | 1672 | RSS: Main: 419270656 02:52:33 INFO - PROCESS | 1672 | 02:55:36 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-ext.html (next: http://localhost:49290/tests/dromaeo/cssquery-jquery.html) 02:55:37 INFO - PROCESS | 1672 | RSS: Main: 379674624 02:55:37 INFO - PROCESS | 1672 | 02:58:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49290/tests/dromaeo/cssquery-mootools.html) 02:58:40 INFO - PROCESS | 1672 | RSS: Main: 379449344 02:58:40 INFO - PROCESS | 1672 | 03:01:42 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49290/tests/dromaeo/cssquery-prototype.html) 03:01:43 INFO - PROCESS | 1672 | RSS: Main: 341561344 03:01:43 INFO - PROCESS | 1672 | 03:04:46 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49290/tests/dromaeo/cssquery-yui.html) 03:04:46 INFO - PROCESS | 1672 | RSS: Main: 344088576 03:04:46 INFO - PROCESS | 1672 | 03:07:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-yui.html (next: http://localhost:49290/tests/dromaeo/cssquery-dojo.html) 03:07:50 INFO - PROCESS | 1672 | RSS: Main: 382844928 03:07:50 INFO - PROCESS | 1672 | 03:07:50 INFO - PROCESS | 1672 | __start_tp_report 03:07:50 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 03:07:50 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 03:07:50 INFO - PROCESS | 1672 | |i|pagename|runs| 03:07:50 INFO - PROCESS | 1672 | |0;dojo.html;3380.695737383636;3447.6379980102106;3458.1700391905943;3475.7219422446205;3515.0509362472135;5392.352917649878;5418.349798024243;5635.802746903859;5653.8586535336635;5665.660060396379;5631.662100273976;5659.066254068084;5668.829935101953;5671.517920976722;5674;5101.9744901275535;5118.744062796845;5131.538161565459;5135.1526998045465;5197;5187.844364669066;5205.9219111713355;5205.947940520603;5209.400918894319;5212.192110222922;5178.14560597501;5180.948190518103;5188.299579556769;5196.870078248036;5197.922031169535;5171.715555644438;5178.093833579127;5179.5079467450905;5192.870178245536;5193.298904647862;4909.852704418873;5094.490550944876;5118.692878427306;5212.374515058179;5215.58275337972;5578.888422231573;5654.010548154098;5669.26299581056;5669.376368599451;5682.232898558683;6174.197354343952;6182.814515564541;6200.751969921198;6205.007198848162;6211.006239001738;5099.311592934943;6088.756449742049;6094.451499365034;6151.846203844895;6180.134781130645;4851.75741212945;5796.536277097822;5804.59367844251;5809.535237181015;5878.882422351529;6179.721912513947;6183.165272688219;6193.040078787795;6208.192934918522;6244.12582238487;6012.8797424052145;6046.032634778502;6102.542309326818;6130.031268545464;6131.356207598227;6145.8156255312415;6150.231221097363;6182.845428864224;6195.380461953769;6197.5351848611535;6116.969415152896;6136.417040381157;6152.384761523901;6154.230721159855;6159.384061593805;5207.29701490294;6039.637621742621;6120.90429240112;6161.353057928853;6218.5647004710145;4788.473267940523;4815.759212039384;4825.252085926687;4837.604631073068;4881.389826271716;4355.216061108968;4368.27923392643;4374.256376416017;4377.277749171351;4414.624756895636;5512.862178445571;5568.192612071227;5634.154876768517;5662.971685141548;5693.17448969897;6222.3466536013975;6232.56372053961;6241;6242.906356404657;6243.219597550306;5484.890302193934;5549.278593782782;5559.749811258503;5577.9163312550345;5586.525145362609;5304.628675992721;5318.7074710891275;5337.919931201035;5350.491703288181;5378;6251.749930002749;6261.5616906816995;6302.180716506825;6302.464290535356;6320.652364119926;6121.724522396414;6168.568200225941;6178.721957511832;6254.999200127958;6261.592996455216;6308.526860485574;6338.049292606146;6355.90466142999;6360.809175724736;6371.362863713592;6115.785947491817;6138.1713468681155;6139.9079013813935;6156.630602163885;6159.6612186330185;5981.162637230704;6032.758689652364;6046.27444706638;6249.093881387083;6253.5935164216;4491.393661855608;5894.056950888009;5918.3489816121055;5970.701464926823;5975.342712301556;5907.5273978080795;5909.527237820878;5910.290765108214;5919.644821310735;5957.910631340446;5797.985352563369;5860.648361098348;5862.091375836752;5862.296524417097;5875.148103525051;4911.8280860169725;6024.0662697282;6089.482393996383;6098.054801505774;6125.540584456095;5936.703164841654;5955.255593050869;5956.047032474783;5960.314563825215;5968.403159683997 03:07:50 INFO - PROCESS | 1672 | |1;ext.html;458.63080220422546;462.0850715583147;506.79728108756507;537.2612657595807;581.5347721822541;37158.81420592897;37694;37723;37741;37815.621843781555;40127.59872401275;40696.59303406965;40701;40839.79580102103;40924.795376023154;9355.391899526527;9554.474503902282;9560.904390956071;9563.043695630417;9568.330216884786;9392.718218453458;9572.377795443308;9578.090081442251;9679.322447428684;9704;9626.422414655142;9700.320977531575;9725.465099419529;9733;9748.31761776676;9621;9711.805763884753;9715.951420242924;9726.805463890683;9739.56171972263;9484.383515071499;9609.807803843954;9619.711408657751;9637.855432168522;9642.855357169648;38680.226395472215;39167.8041609793;39209;39277.821665350086;39326.21347573061;3055.052933590594;3122.266267427153;3136.2629782001213;3188.5536024956523;3502.6847583717586;28564.428711425862;28966.42067158645;29186.562201566994;29766.66050027732;29779.788537005938;2617.175589689242;2635.907743228997;2795.105566218811;2834.985825070882;2849.2307077089276;460576.6971165156;475081.24918750714;477261;477716;478715;42867.92830179271;59857;60675.69662151749;60714.696426517585;60832;57825.71087144537;58718;58845.41154588485;58869;58957.705211474524;14303.78544321836;14649.34077966494;15367.001144925543;15568.299426525833;15737.921310393604;11860.525578976743;11956.940215298868;11960.820587691192;11970.58102966392;11993.760124797629;16439.506814795575;16758.497245082668;18479.168437420347;18487.260509579733;18839.90580047091;6811.863762724718;8232.62953167109;8327.50034997902;8359.205875441823;8437.915620843713;946.1248345280588;955.7897262602216;957.7318350861769;1054.9525271362807;1073.0557109743377;28531.429371412454;29296.707032929397;29447.26381840471;29529.557056643738;30068.097957061324;1056.7146870344964;1090.334895713614;1108.933463992163;1121.6466812953893;1146.6158836789602;13778.16810043706;13814.37835297394;13835.30823458823;13885.958553108558;14045.71908561823;533216;536168.6383136197;541538;542002;542606;52773.94452110936;53012;53062.938741224956;53066.7346663272;53076.20385694218;1262.1039062265895;1309.2471828698347;1411.8094057302133;1428.9285535723172;1544.4208421841809;26945.0569230076;27202.863985679945;27269.45461090807;27387;27469.450610987267;42346.94132646709;42701.786491067345;42761.35857962071;42770.78614606907;42872;459119;498685;505646;506465;510142;28072.29819254535;28217.576736349383;28483.860645574772;28578.57132142978;28584.857075714488;38110.856674299815;38255.61744382632;38711.806440967615;38790;38810.80594597009;30367.63345649407;30983.845080774452;33746.3250734979;33798;34203;34355.797547085735;34568.65431345755;34625.480617791254;34696.30607387787;35147.824260879555;32629.34741305208;33356.99929002134;33754.156146096546;33801.661983380836;33899.322013560086;29297.70702293035;30142.69857301399;30195;30213.848930755204;31021.224469388446;18288.81711182871;19354.903225483784;19668.80331196727;20030;23973.40066498282 03:07:50 INFO - PROCESS | 1672 | |2;jquery.html;359.81469543185256;360.2866324677139;364.3969230922822;372.16820406391724;381.511665068712;15432.691346173098;15443.691126177499;18815.62368752626;19802.504937376572;20319.492012699673;11665.883341166586;12056.156069075168;12080.214786038901;19820;20344;3994.0813612869056;5253.921191182126;5432.13085906255;5435.673859568419;5441.619086663935;4101.897452563695;4116.506019277691;4124.896877578055;4129.318662420712;4139.689523285766;4114.280000999828;5755.971220143893;6053.092036194584;6292.968535157318;6654.600723956578;5439.238506609078;6532.804015879531;6599.10912026875;6603.669816509156;6606.3063378345305;5395.892082158335;5425.457454254582;5453.7818487260465;5458.836234912959;5468.343798744176;12915.612531624067;13132.934335328262;13159.276239806806;13161.934190328988;18152.546186345317;2166.850451715636;2205.9669104963436;2226.476777957179;2242.8766417847173;2768.8892444302205;7359.521631093961;8549.760284758737;9013.278937684969;9423.01058388873;9527.666531671359;1729.144073683522;1764.461839139062;1804.3233787329752;1830.130687923239;1850.1766713812358;87612.56193719055;94698.52650736771;94940;95396;96771.51614241954;10746.677599672023;11432.199746017699;11451.427428628534;11461.083113350913;11514.884851151548;13629.795553066711;13699.657508562366;13700.314984250947;13703.794443083361;13735.519256825963;7015.8596828063155;8146.918530814616;8320.542370169578;8414.158584141536;8423.368247381472;8327.458715183493;8339.499630022217;8341.24928756415;8409.369297302726;8416.831663366698;4034.23349563582;4175.872514421089;4453.398791163217;4527.388802511618;4584.106099310669;1599.336275445677;1845.8892466452055;1864.123861784959;1872.925082996665;1890.9621807563772;841.335345077382;928.6203780031228;933.2394098809449;960.1742501448748;1021.2902033087082;19231.326903558307;19938;20092;20252.696209556867;20825.791742082387;861.500329808722;885.6324625280565;986.413084214891;1037.6731329631293;1052.9473526323652;7474.022180389133;10836.945815270874;10917.144085505483;11676.883231167749;11739.589114381126;275427;747071;747776;756645;768627;84399.29408118023;84752.86330618765;109986;110942;115393.4230328843;1148.4200478758173;1164.1210885781181;1175.6884425627215;1192.7674103549725;1193.0813273779315;18139.90930045341;18416.81583184151;18518;18540.351087711864;18672.346467874104;36712.63287367092;51237;51389.486105139964;52312;54451.72774136104;64211;69058.65470672614;70399.29600703927;70630;71929.6403517979;6740.325967403221;7611.923880761122;7653.158152603098;7697.345725613385;7782.1828707987115;7072.893906591508;8311.95844020776;8426.957865210634;8749.431286966326;9573.856392153984;7505.4746167767735;7531.472796904383;7653;7816.335611472861;7850.175731548105;6415.871682566416;7585.506942048749;7616.504927179715;7837.882431763414;7871.685132594632;7645.617719114133;7891.68433262686;7976.282134607914;7999.200079991954;8026.558539280396;9261.72214833556;10918.739172855838;11174.608888688857;11306.604268850551;11318.717032074264;10634.787304254027;10662.626808061681;10872.891271087505;11013.118950483782;11168.776624467302 03:07:50 INFO - PROCESS | 1672 | |3;mootools.html;1258.276491017665;1526.4199604150424;1559.329488320022;1790.4002159276642;1934.1779743608963;7245.456590755694;7919.643616037278;8723.21491065804;8726.301895848334;8726.694565690203;7303.817404564876;8435.536045517494;8708.303335733142;8718.73843784686;8798.736037918856;2191;2254.357508110189;2449.3998970252223;2459.741727118649;2507;2484.0312278211513;2519.911803086892;2520.5589021921182;2526.3305224115625;2528.4943011397704;2475.170817776047;2502.6120951252583;2507.0723832182025;2508.6989561252585;2509.736477669846;2415.420299128214;2487.738787427312;2488.6515887775727;2488.875556222182;2489.9128530501434;2426.502566973784;2444.8655323957355;2493.9127130550523;2494.2143224884103;2497.600383938561;7906.051273847118;8844.823103537894;8952.776180595472;8958.910410895873;8974.820503589892;5034.874128146789;5505.779768809243;5509.807156749494;5517.034518959166;5518.944810551883;3632.527771389729;3669.94495082574;3728;3729.198222382201;3747.9437808432895;1042.650712011477;1048.035807057509;1049.3074570783322;1097.544519024604;1101.9889801101967;11793.115516336224;11960.043196544255;11960.401979901057;11993.760124797454;12041.759164816742;4895;4925.088858561177;5047.924281135786;5052.1663925451885;5053;10340.431276279727;10341.63804266847;10354;10354.223433242538;10371.740706482398;5512.283403157644;5523.8066667666435;5561.332640083135;5569.470900264469;5597.440255974451;4905.705657660552;5018.347614810052;5023.447420783711;5029.5724863386295;5032.446430892599;3715.442683597482;3809.485719427897;3957.149212919179;3970.285348637215;4010.859619913289;1298.571471414431;1306.2097431054265;1308.3719814489098;1316.3615646411483;1317.617890811673;1323.1069028405789;1329.4017692038622;1334.0728193905336;1342.0408000359184;1361.339750221142;8204.630791614392;8221.630026648816;8229.711960081488;8237.588120593946;8261.297789687944;1123.7640095579857;1130.5647325779469;1149.8677652069953;1192.6486572730655;1198.5385626533848;6175.752969881154;6202.4417802398;6271.3415091414745;6278.30938596754;6295.748170073238;9606.855897161548;10727.892721072845;10733.624323148651;10842.29525080883;10845.620403285848;10315.535800888827;10617.150627949746;10699.304545204537;10737.03366697001;10748.570057197625;8253.504789712637;8258.339332853357;8264.173582641808;8331.166883311742;8342.791430214293;7719.884201737091;7864.921350786648;7918.802029949297;7947.403944704055;7948.920510794818;9296.488693121673;9524.809503809747;9529.142377186086;9624.326297159132;9627.422354658744;9670.274729395183;9888.851667224853;9972.052654997764;10076.949615251877;10087.89912100899;6882.242953275036;7498.737544186146;7518.060242469692;7541.2458754124145;7589.1272503660575;7704.19105993885;8053.114157442559;8250.752477425687;8250.958745206235;8254.628541715518;7545.396368290633;7670;7698;7827.334676552329;7838.294553489985;7416.6291685414435;7507.737229196952;7571.091469023752;7614.733484328022;7634.770956871303;7680;7743.341815945482;7746.65140068687;7752.5348479091435;7765.301122898966;6938.098047253825;6956.373926346653;7017.929820701727;7018.859622807618;7035.613041282574;7111.2888711130545;7121.715131394686;7152.785416437515;7155.248698886542;7155.499115061895 03:07:50 INFO - PROCESS | 1672 | |4;prototype.html;325.0670575448463;329.881242752609;335.1520652748546;336.21829247000727;339.49245877413273;6473.44975677068;6492;6512.460140545185;6527.347265273476;6541.149650545422;6416.294207637168;6428.935710642892;6434.935650643492;6450.709718062687;6451.870842641327;4581.289900065495;4800.255960326138;4801.039792041588;4806.327114204014;4807.110684523357;4586.678932474728;4697.88255293617;4723.598494127986;4724.480307166209;4740.691855029412;3781.6596506314427;3945.5659877413464;4673.83641572545;4675.532446755315;4680.134175177586;4499.842505512292;4590.08198360326;4611.930821037688;4676.883077923045;4707.082118986799;3552.6447355264527;3782.71629627779;4032.334664780308;4032.9798351008058;4056.6551843093075;5140.948590514085;5477.685355514687;5931.288245410536;6194.194754681907;6204.627722336629;5324.787008519694;5362.973185134088;5432.809851655173;5441.700706461143;5447.210154527611;5756.625819321773;6645.4683625310345;6774.187097548326;6850.38346548813;6883.793486195422;4470.173017991649;4475.597196252353;4482.148391805579;4485.9906521032835;4494.123645889053;5670.319561652628;6809.808283550359;6939.981108217941;7170.498065135443;7186.137663480364;3626.3472574936236;4711.128441238382;4725.078609671081;4730.905381892343;4736.5973892219545;4779.064478886056;4783.258594917794;4792.329073929653;4796.664233503621;4800.783964721596;5356.598255130881;5548.528375088163;5552.167174923794;5558.833235002957;5568.443155684399;5487.560995120461;6790.7623233186605;6794.558353706993;6801.1158549388265;6808.3532064454785;1645.3171933647402;1678.7146185148554;1681.4115059729243;1683.671684021604;1686.376040864888;897.6768363389175;1090.5038207615517;1104.917131215146;1105.6296140792763;1115.503600897609;5174.741262936914;6402.9359706403275;6420.261669907927;6443.6455994920725;6445.871082578416;7176.7846964591145;7177.03110080143;7179.174394944648;7181.210066892638;7189.35295823368;6180.6600636965395;6388.648624325707;6393.808185754435;6407.935920640827;6413.647249401234;3785.37541305687;3815.6184381562175;3816.9427458588143;3818.8663396781535;3821.5032045833864;7588.344079572105;7605.467617266738;7606.315431611181;7614.933909252709;7632.427567932316;6386.393292637192;7186.712531498786;7271.163816161209;7395.334419902235;7475.775726728207;7315.451341149329;7575.886361704689;7616.162222155448;7631;7638.694452221849;6956.686949087202;7251.8187045324285;7251.927480725125;7262.913261863581;7264.673089711081;5707.372189059283;7125.572465652078;7135.429165666838;7139.643017849191;7149.177844547944;7408.444366672629;7545.358644515278;7552.509086909334;7564.810879728051;7565.8108547284555;3800.7339486235696;3912.7847968360875;4413.117376524772;4472.597466228055;4561.703489273186;5747.540196784331;7144.678489467882;7153.570785752871;7166.954044531158;7178.138623365229;5637.3235211774845;6852.972054191911;6906.8618627628175;6915.343042411164;6927.134108236471;6610.933890661224;6906.723731050903;6909.965450172717;6921.7231310747;6931.306869313028;6746.190457145174;6753.15585551806;6756.69594868242;6774.4580433564215;6786.185657721105;6877.759278425231;6916.273791251846;6920.792376228721;6932.306769323028;6940.757073502403;6054.9101161791305;6124.38756124384;6408.839779005562;6725.730970761115;6743.966280168568 03:07:50 INFO - PROCESS | 1672 | |5;yui.html;632.6330728177658;698.7903628911325;734.3501001613571;748.6182047155949;790.4940837863768;13089.738205235913;14874.405023799049;15006.624834379147;15030.849691503081;15072.773908391382;15166.848331516681;15513.612159696013;15513.68972620547;15514.224288785572;15596.986195897258;674.7199912036499;682.6723172877022;828.7430896422113;844.624142256693;847.1613103027988;706.5336877660745;826.6775957376628;828.5401602110826;842.8230071684953;844.2064459408167;891.9910800892005;895.444824208988;895.4537731983485;895.8253140637578;895.8253140637578;712.458531516049;721.6860665610476;863.1627321498199;879.1647934462286;883.9469631822111;654.8853950558633;656.2518728649344;656.4092316914767;656.5108993799602;658.0852614865341;14833.110013399122;14882.10707357562;14890.851091489054;14899.404023839033;14924.477643282542;12246.755064898742;12378.876211237863;12600.936995315056;12911.289879056649;13165.341732913412;10084.193264538893;10090.293679442442;10096.242781791396;10165;10886.0746836519;3471.7743346682637;3508.4211105167615;3511.315293517765;3518.6481351864863;3587.3004764071015;77094;77195.61402192953;78107;78159;78237;9254.676086336945;9372.531373431437;9461.574229159703;9475.384100033614;9809.656662016938;20161.697574536392;20429;20676.17295308201;20682.68975965362;20749.377518674464;7452.590107544029;7548.635806711895;7607.429442791813;7725.8454830903065;7855.489393189425;3971.285168669667;4071.246819338432;4152.896177595584;4153.1486045360625;4278.4865816102265;3514.156602415453;3547.467879817996;3578.284343131384;3578.964210357863;3583.552055993001;647.2879832184559;657.7927952694981;658.6640813185214;666.4268728893148;674.2953613473834;520.9973950130225;551.3439007580965;595.532506982017;622.4553515673786;632.8417895526119;8485.575721214038;8537.74386768398;8642.913570864337;8661.913380866237;8750.124987501198;466.23304663827815;483.20271551939584;583.9795607153729;613.1171113596407;620.872721092175;3486.0761898097026;3647.908802279964;3799.6306327271045;4045.4943132108488;4189.539150693421;83370.74943875847;83628;84669;84894.57552712197;85127.14872851192;73758.26241737622;73854;74375;74572.25427745761;74909;64721.029184561325;65152.67423662851;66128.00807987884;66188;66812.33187668158;8116.83766324682;8185.754427367188;8240.299574535991;8253.257206851413;8295.211954864279;40105.99735006648;40565.79717101395;42590.78704606457;43531.78234108809;44679.776601116784;56131;58929.70535147297;62282.37717622766;62764.68617656882;63272;9764.80470390574;10111.292209545261;10245.692629221136;10305.381677099398;10530.947345263532;11966.880331196577;11990.760184796429;12181.634550963485;12489;12916.547920822726;11498.82751758741;11646.94176529112;11827;11882.940585297018;12362.44369003379;10904.309831976056;11410.828837567276;11415.029722473682;11628.825567616661;12332.753344933231;10969.670909872717;11103.555857765921;11252.987231149236;11259.042981346678;11332.830007549728;9221.262299015929;9250.352475326932;9463.668771593237;9869.210463163074;9975.401475911469;9069;9273.979862215016;9489.95255023748;10044.296899216984;10052 03:07:50 INFO - PROCESS | 1672 | __end_tp_report 03:07:50 INFO - PROCESS | 1672 | __start_cc_report 03:07:50 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,2079 03:07:50 INFO - PROCESS | 1672 | __end_cc_report 03:07:50 INFO - PROCESS | 1672 | __startTimestamp1455102470110__endTimestamp 03:07:50 INFO - PROCESS | 1672 | 03:07:50 INFO - PROCESS | 1672 | ------- Summary: start ------- 03:07:50 INFO - PROCESS | 1672 | Number of tests: 6 03:07:50 INFO - PROCESS | 1672 | 03:07:50 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5657.74 Median:5875.15 stddev:634.45 (10.8%) stddev-sans-first:610.73 03:07:50 INFO - PROCESS | 1672 | Values: 3380.7 3447.6 3458.2 3475.7 3515.1 5392.4 5418.3 5635.8 5653.9 5665.7 5631.7 5659.1 5668.8 5671.5 5674.0 5102.0 5118.7 5131.5 5135.2 5197.0 5187.8 5205.9 5205.9 5209.4 5212.2 5178.1 5180.9 5188.3 5196.9 5197.9 5171.7 5178.1 5179.5 5192.9 5193.3 4909.9 5094.5 5118.7 5212.4 5215.6 5578.9 5654.0 5669.3 5669.4 5682.2 6174.2 6182.8 6200.8 6205.0 6211.0 5099.3 6088.8 6094.5 6151.8 6180.1 4851.8 5796.5 5804.6 5809.5 5878.9 6179.7 6183.2 6193.0 6208.2 6244.1 6012.9 6046.0 6102.5 6130.0 6131.4 6145.8 6150.2 6182.8 6195.4 6197.5 6117.0 6136.4 6152.4 6154.2 6159.4 5207.3 6039.6 6120.9 6161.4 6218.6 4788.5 4815.8 4825.3 4837.6 4881.4 4355.2 4368.3 4374.3 4377.3 4414.6 5512.9 5568.2 5634.2 5663.0 5693.2 6222.3 6232.6 6241.0 6242.9 6243.2 5484.9 5549.3 5559.7 5577.9 5586.5 5304.6 5318.7 5337.9 5350.5 5378.0 6251.7 6261.6 6302.2 6302.5 6320.7 6121.7 6168.6 6178.7 6255.0 6261.6 6308.5 6338.0 6355.9 6360.8 6371.4 6115.8 6138.2 6139.9 6156.6 6159.7 5981.2 6032.8 6046.3 6249.1 6253.6 4491.4 5894.1 5918.3 5970.7 5975.3 5907.5 5909.5 5910.3 5919.6 5957.9 5798.0 5860.6 5862.1 5862.3 5875.1 4911.8 6024.1 6089.5 6098.1 6125.5 5936.7 5955.3 5956.0 5960.3 5968.4 03:07:50 INFO - PROCESS | 1672 | 03:07:50 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:62961.12 Median:37778.31 stddev:134308.85 (355.5%) stddev-sans-first:134603.64 03:07:50 INFO - PROCESS | 1672 | Values: 458.6 462.1 506.8 537.3 581.5 37158.8 37694.0 37723.0 37741.0 37815.6 40127.6 40696.6 40701.0 40839.8 40924.8 9355.4 9554.5 9560.9 9563.0 9568.3 9392.7 9572.4 9578.1 9679.3 9704.0 9626.4 9700.3 9725.5 9733.0 9748.3 9621.0 9711.8 9716.0 9726.8 9739.6 9484.4 9609.8 9619.7 9637.9 9642.9 38680.2 39167.8 39209.0 39277.8 39326.2 3055.1 3122.3 3136.3 3188.6 3502.7 28564.4 28966.4 29186.6 29766.7 29779.8 2617.2 2635.9 2795.1 2835.0 2849.2 460576.7 475081.2 477261.0 477716.0 478715.0 42867.9 59857.0 60675.7 60714.7 60832.0 57825.7 58718.0 58845.4 58869.0 58957.7 14303.8 14649.3 15367.0 15568.3 15737.9 11860.5 11956.9 11960.8 11970.6 11993.8 16439.5 16758.5 18479.2 18487.3 18839.9 6811.9 8232.6 8327.5 8359.2 8437.9 946.1 955.8 957.7 1055.0 1073.1 28531.4 29296.7 29447.3 29529.6 30068.1 1056.7 1090.3 1108.9 1121.6 1146.6 13778.2 13814.4 13835.3 13886.0 14045.7 533216.0 536168.6 541538.0 542002.0 542606.0 52773.9 53012.0 53062.9 53066.7 53076.2 1262.1 1309.2 1411.8 1428.9 1544.4 26945.1 27202.9 27269.5 27387.0 27469.5 42346.9 42701.8 42761.4 42770.8 42872.0 459119.0 498685.0 505646.0 506465.0 510142.0 28072.3 28217.6 28483.9 28578.6 28584.9 38110.9 38255.6 38711.8 38790.0 38810.8 30367.6 30983.8 33746.3 33798.0 34203.0 34355.8 34568.7 34625.5 34696.3 35147.8 32629.3 33357.0 33754.2 33801.7 33899.3 29297.7 30142.7 30195.0 30213.8 31021.2 18288.8 19354.9 19668.8 20030.0 23973.4 03:07:50 INFO - PROCESS | 1672 | 03:07:50 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:33896.15 Median:4490.39 stddev:113268.76 (2522.5%) stddev-sans-first:113558.51 03:07:50 INFO - PROCESS | 1672 | Values: 359.8 360.3 364.4 372.2 381.5 15432.7 15443.7 18815.6 19802.5 20319.5 11665.9 12056.2 12080.2 19820.0 20344.0 3994.1 5253.9 5432.1 5435.7 5441.6 4101.9 4116.5 4124.9 4129.3 4139.7 4114.3 5756.0 6053.1 6293.0 6654.6 5439.2 6532.8 6599.1 6603.7 6606.3 5395.9 5425.5 5453.8 5458.8 5468.3 12915.6 13132.9 13159.3 13161.9 18152.5 2166.9 2206.0 2226.5 2242.9 2768.9 7359.5 8549.8 9013.3 9423.0 9527.7 1729.1 1764.5 1804.3 1830.1 1850.2 87612.6 94698.5 94940.0 95396.0 96771.5 10746.7 11432.2 11451.4 11461.1 11514.9 13629.8 13699.7 13700.3 13703.8 13735.5 7015.9 8146.9 8320.5 8414.2 8423.4 8327.5 8339.5 8341.2 8409.4 8416.8 4034.2 4175.9 4453.4 4527.4 4584.1 1599.3 1845.9 1864.1 1872.9 1891.0 841.3 928.6 933.2 960.2 1021.3 19231.3 19938.0 20092.0 20252.7 20825.8 861.5 885.6 986.4 1037.7 1052.9 7474.0 10836.9 10917.1 11676.9 11739.6 275427.0 747071.0 747776.0 756645.0 768627.0 84399.3 84752.9 109986.0 110942.0 115393.4 1148.4 1164.1 1175.7 1192.8 1193.1 18139.9 18416.8 18518.0 18540.4 18672.3 36712.6 51237.0 51389.5 52312.0 54451.7 64211.0 69058.7 70399.3 70630.0 71929.6 6740.3 7611.9 7653.2 7697.3 7782.2 7072.9 8312.0 8427.0 8749.4 9573.9 7505.5 7531.5 7653.0 7816.3 7850.2 6415.9 7585.5 7616.5 7837.9 7871.7 7645.6 7891.7 7976.3 7999.2 8026.6 9261.7 10918.7 11174.6 11306.6 11318.7 10634.8 10662.6 10872.9 11013.1 11168.8 03:07:50 INFO - PROCESS | 1672 | 03:07:50 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:6083.28 Median:5052.58 stddev:3171.62 (62.8%) stddev-sans-first:3159.77 03:07:50 INFO - PROCESS | 1672 | Values: 1258.3 1526.4 1559.3 1790.4 1934.2 7245.5 7919.6 8723.2 8726.3 8726.7 7303.8 8435.5 8708.3 8718.7 8798.7 2191.0 2254.4 2449.4 2459.7 2507.0 2484.0 2519.9 2520.6 2526.3 2528.5 2475.2 2502.6 2507.1 2508.7 2509.7 2415.4 2487.7 2488.7 2488.9 2489.9 2426.5 2444.9 2493.9 2494.2 2497.6 7906.1 8844.8 8952.8 8958.9 8974.8 5034.9 5505.8 5509.8 5517.0 5518.9 3632.5 3669.9 3728.0 3729.2 3747.9 1042.7 1048.0 1049.3 1097.5 1102.0 11793.1 11960.0 11960.4 11993.8 12041.8 4895.0 4925.1 5047.9 5052.2 5053.0 10340.4 10341.6 10354.0 10354.2 10371.7 5512.3 5523.8 5561.3 5569.5 5597.4 4905.7 5018.3 5023.4 5029.6 5032.4 3715.4 3809.5 3957.1 3970.3 4010.9 1298.6 1306.2 1308.4 1316.4 1317.6 1323.1 1329.4 1334.1 1342.0 1361.3 8204.6 8221.6 8229.7 8237.6 8261.3 1123.8 1130.6 1149.9 1192.6 1198.5 6175.8 6202.4 6271.3 6278.3 6295.7 9606.9 10727.9 10733.6 10842.3 10845.6 10315.5 10617.2 10699.3 10737.0 10748.6 8253.5 8258.3 8264.2 8331.2 8342.8 7719.9 7864.9 7918.8 7947.4 7948.9 9296.5 9524.8 9529.1 9624.3 9627.4 9670.3 9888.9 9972.1 10076.9 10087.9 6882.2 7498.7 7518.1 7541.2 7589.1 7704.2 8053.1 8250.8 8251.0 8254.6 7545.4 7670.0 7698.0 7827.3 7838.3 7416.6 7507.7 7571.1 7614.7 7634.8 7680.0 7743.3 7746.7 7752.5 7765.3 6938.1 6956.4 7017.9 7018.9 7035.6 7111.3 7121.7 7152.8 7155.2 7155.5 03:07:50 INFO - PROCESS | 1672 | 03:07:50 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5578.04 Median:6391.23 stddev:1800.79 (28.2%) stddev-sans-first:1762.15 03:07:50 INFO - PROCESS | 1672 | Values: 325.1 329.9 335.2 336.2 339.5 6473.4 6492.0 6512.5 6527.3 6541.1 6416.3 6428.9 6434.9 6450.7 6451.9 4581.3 4800.3 4801.0 4806.3 4807.1 4586.7 4697.9 4723.6 4724.5 4740.7 3781.7 3945.6 4673.8 4675.5 4680.1 4499.8 4590.1 4611.9 4676.9 4707.1 3552.6 3782.7 4032.3 4033.0 4056.7 5140.9 5477.7 5931.3 6194.2 6204.6 5324.8 5363.0 5432.8 5441.7 5447.2 5756.6 6645.5 6774.2 6850.4 6883.8 4470.2 4475.6 4482.1 4486.0 4494.1 5670.3 6809.8 6940.0 7170.5 7186.1 3626.3 4711.1 4725.1 4730.9 4736.6 4779.1 4783.3 4792.3 4796.7 4800.8 5356.6 5548.5 5552.2 5558.8 5568.4 5487.6 6790.8 6794.6 6801.1 6808.4 1645.3 1678.7 1681.4 1683.7 1686.4 897.7 1090.5 1104.9 1105.6 1115.5 5174.7 6402.9 6420.3 6443.6 6445.9 7176.8 7177.0 7179.2 7181.2 7189.4 6180.7 6388.6 6393.8 6407.9 6413.6 3785.4 3815.6 3816.9 3818.9 3821.5 7588.3 7605.5 7606.3 7614.9 7632.4 6386.4 7186.7 7271.2 7395.3 7475.8 7315.5 7575.9 7616.2 7631.0 7638.7 6956.7 7251.8 7251.9 7262.9 7264.7 5707.4 7125.6 7135.4 7139.6 7149.2 7408.4 7545.4 7552.5 7564.8 7565.8 3800.7 3912.8 4413.1 4472.6 4561.7 5747.5 7144.7 7153.6 7167.0 7178.1 5637.3 6853.0 6906.9 6915.3 6927.1 6610.9 6906.7 6910.0 6921.7 6931.3 6746.2 6753.2 6756.7 6774.5 6786.2 6877.8 6916.3 6920.8 6932.3 6940.8 6054.9 6124.4 6408.8 6725.7 6744.0 03:07:50 INFO - PROCESS | 1672 | 03:07:50 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:17368.07 Median:621.66 stddev:23744.21 (3819.5%) stddev-sans-first:23777.57 03:07:50 INFO - PROCESS | 1672 | Values: 632.6 698.8 734.4 748.6 790.5 13089.7 14874.4 15006.6 15030.8 15072.8 15166.8 15513.6 15513.7 15514.2 15597.0 674.7 682.7 828.7 844.6 847.2 706.5 826.7 828.5 842.8 844.2 892.0 895.4 895.5 895.8 895.8 712.5 721.7 863.2 879.2 883.9 654.9 656.3 656.4 656.5 658.1 14833.1 14882.1 14890.9 14899.4 14924.5 12246.8 12378.9 12600.9 12911.3 13165.3 10084.2 10090.3 10096.2 10165.0 10886.1 3471.8 3508.4 3511.3 3518.6 3587.3 77094.0 77195.6 78107.0 78159.0 78237.0 9254.7 9372.5 9461.6 9475.4 9809.7 20161.7 20429.0 20676.2 20682.7 20749.4 7452.6 7548.6 7607.4 7725.8 7855.5 3971.3 4071.2 4152.9 4153.1 4278.5 3514.2 3547.5 3578.3 3579.0 3583.6 647.3 657.8 658.7 666.4 674.3 521.0 551.3 595.5 622.5 632.8 8485.6 8537.7 8642.9 8661.9 8750.1 466.2 483.2 584.0 613.1 620.9 3486.1 3647.9 3799.6 4045.5 4189.5 83370.7 83628.0 84669.0 84894.6 85127.1 73758.3 73854.0 74375.0 74572.3 74909.0 64721.0 65152.7 66128.0 66188.0 66812.3 8116.8 8185.8 8240.3 8253.3 8295.2 40106.0 40565.8 42590.8 43531.8 44679.8 56131.0 58929.7 62282.4 62764.7 63272.0 9764.8 10111.3 10245.7 10305.4 10530.9 11966.9 11990.8 12181.6 12489.0 12916.5 11498.8 11646.9 11827.0 11882.9 12362.4 10904.3 11410.8 11415.0 11628.8 12332.8 10969.7 11103.6 11253.0 11259.0 11332.8 9221.3 9250.4 9463.7 9869.2 9975.4 9069.0 9274.0 9490.0 10044.3 10052.0 03:07:50 INFO - PROCESS | 1672 | -------- Summary: end -------- 03:07:50 INFO - PROCESS | 1672 | 03:07:50 INFO - TEST-INFO | 1672: exit 0 03:07:50 INFO - TEST-OK | dromaeo_css | took 1115077ms 03:07:50 INFO - TEST-START | kraken 03:07:50 INFO - operating with platform_type : mac_ 03:07:50 INFO - Initialising browser for kraken test... 03:07:50 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpfmyzjG/profile http://localhost:49290/getInfo.html) 03:07:52 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 03:07:52 INFO - PROCESS | 1681 | colorDepth:24 03:07:52 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 03:07:52 INFO - PROCESS | 1681 | __metrics 03:07:52 INFO - PROCESS | 1681 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:07:52 INFO - PROCESS | 1681 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:07:53 INFO - TEST-INFO | 1681: exit 0 03:07:53 INFO - Browser initialized. 03:07:53 INFO - Running cycle 1/1 for kraken test... 03:07:53 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpfmyzjG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:05 INFO - PROCESS | 1683 | RSS: Main: 245293056 03:08:05 INFO - PROCESS | 1683 | 03:08:07 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:08 INFO - PROCESS | 1683 | RSS: Main: 291692544 03:08:08 INFO - PROCESS | 1683 | 03:08:11 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-dft) 03:08:11 INFO - PROCESS | 1683 | RSS: Main: 302141440 03:08:11 INFO - PROCESS | 1683 | 03:08:14 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-fft) 03:08:15 INFO - PROCESS | 1683 | RSS: Main: 288731136 03:08:15 INFO - PROCESS | 1683 | 03:08:17 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-oscillator) 03:08:18 INFO - PROCESS | 1683 | RSS: Main: 291749888 03:08:18 INFO - PROCESS | 1683 | 03:08:20 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:20 INFO - PROCESS | 1683 | RSS: Main: 293208064 03:08:20 INFO - PROCESS | 1683 | 03:08:23 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:23 INFO - PROCESS | 1683 | RSS: Main: 293294080 03:08:23 INFO - PROCESS | 1683 | 03:08:26 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:27 INFO - PROCESS | 1683 | RSS: Main: 292380672 03:08:27 INFO - PROCESS | 1683 | 03:08:30 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49290/tests/kraken/driver.html?testName=json-parse-financial) 03:08:30 INFO - PROCESS | 1683 | RSS: Main: 291815424 03:08:30 INFO - PROCESS | 1683 | 03:08:32 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49290/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:08:32 INFO - PROCESS | 1683 | RSS: Main: 327061504 03:08:32 INFO - PROCESS | 1683 | 03:08:34 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:08:35 INFO - PROCESS | 1683 | RSS: Main: 326852608 03:08:35 INFO - PROCESS | 1683 | 03:08:37 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:08:37 INFO - PROCESS | 1683 | RSS: Main: 334077952 03:08:37 INFO - PROCESS | 1683 | 03:08:40 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:08:41 INFO - PROCESS | 1683 | RSS: Main: 336293888 03:08:41 INFO - PROCESS | 1683 | 03:08:43 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:08:44 INFO - PROCESS | 1683 | RSS: Main: 335749120 03:08:44 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49290/tests/kraken/driver.html?testName=ai-astar) 03:08:46 INFO - PROCESS | 1683 | RSS: Main: 395960320 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | __start_tp_report 03:08:46 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 03:08:46 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 03:08:46 INFO - PROCESS | 1683 | |i|pagename|runs| 03:08:46 INFO - PROCESS | 1683 | |0;ai-astar;109;107;109;111;110;111;116;111;109;110 03:08:46 INFO - PROCESS | 1683 | |1;audio-beat-detection;159;124;149;151;100;164;169;119;159;117 03:08:46 INFO - PROCESS | 1683 | |2;audio-dft;187;186;186;183;184;185;185;186;181;191 03:08:46 INFO - PROCESS | 1683 | |3;audio-fft;73;80;84;80;73;86;47;85;69;52 03:08:46 INFO - PROCESS | 1683 | |4;audio-oscillator;95;94;126;79;81;84;106;77;77;110 03:08:46 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;85;90;83;90;84;89;84;90;85;89 03:08:46 INFO - PROCESS | 1683 | |6;imaging-darkroom;94;94;94;94;95;93;93;100;141;111 03:08:46 INFO - PROCESS | 1683 | |7;imaging-desaturate;85;86;86;86;87;85;87;86;84;85 03:08:46 INFO - PROCESS | 1683 | |8;json-parse-financial;54;54;53;54;55;54;55;63;53;53 03:08:46 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;65;61;72;73;69;65;65;66;67;69 03:08:46 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;84;82;82;82;95;83;82;83;83;84 03:08:46 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;111;144;133;132;114;124;139;135;127;112 03:08:46 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;138;157;188;134;137;124;138;137;137;136 03:08:46 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;66;69;83;96;95;71;66;67;65;67 03:08:46 INFO - PROCESS | 1683 | __end_tp_report 03:08:46 INFO - PROCESS | 1683 | __start_cc_report 03:08:46 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1197 03:08:46 INFO - PROCESS | 1683 | __end_cc_report 03:08:46 INFO - PROCESS | 1683 | __startTimestamp1455102526308__endTimestamp 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | ------- Summary: start ------- 03:08:46 INFO - PROCESS | 1683 | Number of tests: 14 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:2.36 (2.1%) stddev-sans-first:2.46 03:08:46 INFO - PROCESS | 1683 | Values: 109.0 107.0 109.0 111.0 110.0 111.0 116.0 111.0 109.0 110.0 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:155.00 stddev:23.93 (15.4%) stddev-sans-first:24.49 03:08:46 INFO - PROCESS | 1683 | Values: 159.0 124.0 149.0 151.0 100.0 164.0 169.0 119.0 159.0 117.0 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:185.40 Median:186.00 stddev:2.63 (1.4%) stddev-sans-first:2.73 03:08:46 INFO - PROCESS | 1683 | Values: 187.0 186.0 186.0 183.0 184.0 185.0 185.0 186.0 181.0 191.0 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:72.90 Median:80.00 stddev:13.60 (17.0%) stddev-sans-first:14.43 03:08:46 INFO - PROCESS | 1683 | Values: 73.0 80.0 84.0 80.0 73.0 86.0 47.0 85.0 69.0 52.0 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:80.00 stddev:16.62 (20.8%) stddev-sans-first:17.61 03:08:46 INFO - PROCESS | 1683 | Values: 95.0 94.0 126.0 79.0 81.0 84.0 106.0 77.0 77.0 110.0 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:89.00 stddev:2.92 (3.3%) stddev-sans-first:3.02 03:08:46 INFO - PROCESS | 1683 | Values: 85.0 90.0 83.0 90.0 84.0 89.0 84.0 90.0 85.0 89.0 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:100.90 Median:94.00 stddev:15.13 (16.1%) stddev-sans-first:15.84 03:08:46 INFO - PROCESS | 1683 | Values: 94.0 94.0 94.0 94.0 95.0 93.0 93.0 100.0 141.0 111.0 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:0.95 (1.1%) stddev-sans-first:0.97 03:08:46 INFO - PROCESS | 1683 | Values: 85.0 86.0 86.0 86.0 87.0 85.0 87.0 86.0 84.0 85.0 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:2.97 (5.5%) stddev-sans-first:3.14 03:08:46 INFO - PROCESS | 1683 | Values: 54.0 54.0 53.0 54.0 55.0 54.0 55.0 63.0 53.0 53.0 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:68.00 stddev:3.61 (5.3%) stddev-sans-first:3.75 03:08:46 INFO - PROCESS | 1683 | Values: 65.0 61.0 72.0 73.0 69.0 65.0 65.0 66.0 67.0 69.0 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.00 stddev:3.94 (4.8%) stddev-sans-first:4.18 03:08:46 INFO - PROCESS | 1683 | Values: 84.0 82.0 82.0 82.0 95.0 83.0 82.0 83.0 83.0 84.0 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:132.50 stddev:11.63 (8.8%) stddev-sans-first:10.78 03:08:46 INFO - PROCESS | 1683 | Values: 111.0 144.0 133.0 132.0 114.0 124.0 139.0 135.0 127.0 112.0 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.60 Median:137.50 stddev:17.85 (13.0%) stddev-sans-first:18.86 03:08:46 INFO - PROCESS | 1683 | Values: 138.0 157.0 188.0 134.0 137.0 124.0 138.0 137.0 137.0 136.0 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:70.00 stddev:12.22 (17.5%) stddev-sans-first:12.57 03:08:46 INFO - PROCESS | 1683 | Values: 66.0 69.0 83.0 96.0 95.0 71.0 66.0 67.0 65.0 67.0 03:08:46 INFO - PROCESS | 1683 | -------- Summary: end -------- 03:08:46 INFO - PROCESS | 1683 | 03:08:46 INFO - TEST-INFO | 1683: exit 0 03:08:47 INFO - TEST-OK | kraken | took 56415ms 03:08:47 INFO - SUITE-END | took 1171s 03:08:47 INFO - Completed test suite (00:19:31) 03:08:47 INFO - Working with test: dromaeo_css 03:08:47 INFO - Generating results file: dromaeo_css 03:08:47 INFO - Working with test: kraken 03:08:47 INFO - Generating results file: kraken 03:08:47 INFO - javascript benchmark 03:08:47 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:08:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 03:08:47 INFO - process_Request line: dromaeo_css 7308.57 graph.html#tests=[[72,64,59]] 03:08:47 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:08:48 INFO - process_Request line: kraken 1426.30 graph.html#tests=[[232,64,59]] 03:08:48 INFO - RETURN: dromaeo_css: 7308.57 03:08:48 INFO - RETURN: kraken: 1426.30 03:08:48 INFO - javascript benchmark 03:08:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3380.695737383636, 3447.6379980102106, 3458.1700391905943, 3475.7219422446205, 3515.0509362472135, 5392.352917649878, 5418.349798024243, 5635.802746903859, 5653.8586535336635, 5665.660060396379, 5631.662100273976, 5659.066254068084, 5668.829935101953, 5671.517920976722, 5674.0, 5101.9744901275535, 5118.744062796845, 5131.538161565459, 5135.1526998045465, 5197.0, 5187.844364669066, 5205.9219111713355, 5205.947940520603, 5209.400918894319, 5212.192110222922, 5178.14560597501, 5180.948190518103, 5188.299579556769, 5196.870078248036, 5197.922031169535, 5171.715555644438, 5178.093833579127, 5179.5079467450905, 5192.870178245536, 5193.298904647862, 4909.852704418873, 5094.490550944876, 5118.692878427306, 5212.374515058179, 5215.58275337972, 5578.888422231573, 5654.010548154098, 5669.26299581056, 5669.376368599451, 5682.232898558683, 6174.197354343952, 6182.814515564541, 6200.751969921198, 6205.007198848162, 6211.006239001738, 5099.311592934943, 6088.756449742049, 6094.451499365034, 6151.846203844895, 6180.134781130645, 4851.75741212945, 5796.536277097822, 5804.59367844251, 5809.535237181015, 5878.882422351529, 6179.721912513947, 6183.165272688219, 6193.040078787795, 6208.192934918522, 6244.12582238487, 6012.8797424052145, 6046.032634778502, 6102.542309326818, 6130.031268545464, 6131.356207598227, 6145.8156255312415, 6150.231221097363, 6182.845428864224, 6195.380461953769, 6197.5351848611535, 6116.969415152896, 6136.417040381157, 6152.384761523901, 6154.230721159855, 6159.384061593805, 5207.29701490294, 6039.637621742621, 6120.90429240112, 6161.353057928853, 6218.5647004710145, 4788.473267940523, 4815.759212039384, 4825.252085926687, 4837.604631073068, 4881.389826271716, 4355.216061108968, 4368.27923392643, 4374.256376416017, 4377.277749171351, 4414.624756895636, 5512.862178445571, 5568.192612071227, 5634.154876768517, 5662.971685141548, 5693.17448969897, 6222.3466536013975, 6232.56372053961, 6241.0, 6242.906356404657, 6243.219597550306, 5484.890302193934, 5549.278593782782, 5559.749811258503, 5577.9163312550345, 5586.525145362609, 5304.628675992721, 5318.7074710891275, 5337.919931201035, 5350.491703288181, 5378.0, 6251.749930002749, 6261.5616906816995, 6302.180716506825, 6302.464290535356, 6320.652364119926, 6121.724522396414, 6168.568200225941, 6178.721957511832, 6254.999200127958, 6261.592996455216, 6308.526860485574, 6338.049292606146, 6355.90466142999, 6360.809175724736, 6371.362863713592, 6115.785947491817, 6138.1713468681155, 6139.9079013813935, 6156.630602163885, 6159.6612186330185, 5981.162637230704, 6032.758689652364, 6046.27444706638, 6249.093881387083, 6253.5935164216, 4491.393661855608, 5894.056950888009, 5918.3489816121055, 5970.701464926823, 5975.342712301556, 5907.5273978080795, 5909.527237820878, 5910.290765108214, 5919.644821310735, 5957.910631340446, 5797.985352563369, 5860.648361098348, 5862.091375836752, 5862.296524417097, 5875.148103525051, 4911.8280860169725, 6024.0662697282, 6089.482393996383, 6098.054801505774, 6125.540584456095, 5936.703164841654, 5955.255593050869, 5956.047032474783, 5960.314563825215, 5968.403159683997], "unit": "score", "name": "dojo.html", "value": 5619.939311206223}, {"lowerIsBetter": false, "replicates": [458.63080220422546, 462.0850715583147, 506.79728108756507, 537.2612657595807, 581.5347721822541, 37158.81420592897, 37694.0, 37723.0, 37741.0, 37815.621843781555, 40127.59872401275, 40696.59303406965, 40701.0, 40839.79580102103, 40924.795376023154, 9355.391899526527, 9554.474503902282, 9560.904390956071, 9563.043695630417, 9568.330216884786, 9392.718218453458, 9572.377795443308, 9578.090081442251, 9679.322447428684, 9704.0, 9626.422414655142, 9700.320977531575, 9725.465099419529, 9733.0, 9748.31761776676, 9621.0, 9711.805763884753, 9715.951420242924, 9726.805463890683, 9739.56171972263, 9484.383515071499, 9609.807803843954, 9619.711408657751, 9637.855432168522, 9642.855357169648, 38680.226395472215, 39167.8041609793, 39209.0, 39277.821665350086, 39326.21347573061, 3055.052933590594, 3122.266267427153, 3136.2629782001213, 3188.5536024956523, 3502.6847583717586, 28564.428711425862, 28966.42067158645, 29186.562201566994, 29766.66050027732, 29779.788537005938, 2617.175589689242, 2635.907743228997, 2795.105566218811, 2834.985825070882, 2849.2307077089276, 460576.6971165156, 475081.24918750714, 477261.0, 477716.0, 478715.0, 42867.92830179271, 59857.0, 60675.69662151749, 60714.696426517585, 60832.0, 57825.71087144537, 58718.0, 58845.41154588485, 58869.0, 58957.705211474524, 14303.78544321836, 14649.34077966494, 15367.001144925543, 15568.299426525833, 15737.921310393604, 11860.525578976743, 11956.940215298868, 11960.820587691192, 11970.58102966392, 11993.760124797629, 16439.506814795575, 16758.497245082668, 18479.168437420347, 18487.260509579733, 18839.90580047091, 6811.863762724718, 8232.62953167109, 8327.50034997902, 8359.205875441823, 8437.915620843713, 946.1248345280588, 955.7897262602216, 957.7318350861769, 1054.9525271362807, 1073.0557109743377, 28531.429371412454, 29296.707032929397, 29447.26381840471, 29529.557056643738, 30068.097957061324, 1056.7146870344964, 1090.334895713614, 1108.933463992163, 1121.6466812953893, 1146.6158836789602, 13778.16810043706, 13814.37835297394, 13835.30823458823, 13885.958553108558, 14045.71908561823, 533216.0, 536168.6383136197, 541538.0, 542002.0, 542606.0, 52773.94452110936, 53012.0, 53062.938741224956, 53066.7346663272, 53076.20385694218, 1262.1039062265895, 1309.2471828698347, 1411.8094057302133, 1428.9285535723172, 1544.4208421841809, 26945.0569230076, 27202.863985679945, 27269.45461090807, 27387.0, 27469.450610987267, 42346.94132646709, 42701.786491067345, 42761.35857962071, 42770.78614606907, 42872.0, 459119.0, 498685.0, 505646.0, 506465.0, 510142.0, 28072.29819254535, 28217.576736349383, 28483.860645574772, 28578.57132142978, 28584.857075714488, 38110.856674299815, 38255.61744382632, 38711.806440967615, 38790.0, 38810.80594597009, 30367.63345649407, 30983.845080774452, 33746.3250734979, 33798.0, 34203.0, 34355.797547085735, 34568.65431345755, 34625.480617791254, 34696.30607387787, 35147.824260879555, 32629.34741305208, 33356.99929002134, 33754.156146096546, 33801.661983380836, 33899.322013560086, 29297.70702293035, 30142.69857301399, 30195.0, 30213.848930755204, 31021.224469388446, 18288.81711182871, 19354.903225483784, 19668.80331196727, 20030.0, 23973.40066498282], "unit": "score", "name": "ext.html", "value": 18766.330392553366}, {"lowerIsBetter": false, "replicates": [359.81469543185256, 360.2866324677139, 364.3969230922822, 372.16820406391724, 381.511665068712, 15432.691346173098, 15443.691126177499, 18815.62368752626, 19802.504937376572, 20319.492012699673, 11665.883341166586, 12056.156069075168, 12080.214786038901, 19820.0, 20344.0, 3994.0813612869056, 5253.921191182126, 5432.13085906255, 5435.673859568419, 5441.619086663935, 4101.897452563695, 4116.506019277691, 4124.896877578055, 4129.318662420712, 4139.689523285766, 4114.280000999828, 5755.971220143893, 6053.092036194584, 6292.968535157318, 6654.600723956578, 5439.238506609078, 6532.804015879531, 6599.10912026875, 6603.669816509156, 6606.3063378345305, 5395.892082158335, 5425.457454254582, 5453.7818487260465, 5458.836234912959, 5468.343798744176, 12915.612531624067, 13132.934335328262, 13159.276239806806, 13161.934190328988, 18152.546186345317, 2166.850451715636, 2205.9669104963436, 2226.476777957179, 2242.8766417847173, 2768.8892444302205, 7359.521631093961, 8549.760284758737, 9013.278937684969, 9423.01058388873, 9527.666531671359, 1729.144073683522, 1764.461839139062, 1804.3233787329752, 1830.130687923239, 1850.1766713812358, 87612.56193719055, 94698.52650736771, 94940.0, 95396.0, 96771.51614241954, 10746.677599672023, 11432.199746017699, 11451.427428628534, 11461.083113350913, 11514.884851151548, 13629.795553066711, 13699.657508562366, 13700.314984250947, 13703.794443083361, 13735.519256825963, 7015.8596828063155, 8146.918530814616, 8320.542370169578, 8414.158584141536, 8423.368247381472, 8327.458715183493, 8339.499630022217, 8341.24928756415, 8409.369297302726, 8416.831663366698, 4034.23349563582, 4175.872514421089, 4453.398791163217, 4527.388802511618, 4584.106099310669, 1599.336275445677, 1845.8892466452055, 1864.123861784959, 1872.925082996665, 1890.9621807563772, 841.335345077382, 928.6203780031228, 933.2394098809449, 960.1742501448748, 1021.2902033087082, 19231.326903558307, 19938.0, 20092.0, 20252.696209556867, 20825.791742082387, 861.500329808722, 885.6324625280565, 986.413084214891, 1037.6731329631293, 1052.9473526323652, 7474.022180389133, 10836.945815270874, 10917.144085505483, 11676.883231167749, 11739.589114381126, 275427.0, 747071.0, 747776.0, 756645.0, 768627.0, 84399.29408118023, 84752.86330618765, 109986.0, 110942.0, 115393.4230328843, 1148.4200478758173, 1164.1210885781181, 1175.6884425627215, 1192.7674103549725, 1193.0813273779315, 18139.90930045341, 18416.81583184151, 18518.0, 18540.351087711864, 18672.346467874104, 36712.63287367092, 51237.0, 51389.486105139964, 52312.0, 54451.72774136104, 64211.0, 69058.65470672614, 70399.29600703927, 70630.0, 71929.6403517979, 6740.325967403221, 7611.923880761122, 7653.158152603098, 7697.345725613385, 7782.1828707987115, 7072.893906591508, 8311.95844020776, 8426.957865210634, 8749.431286966326, 9573.856392153984, 7505.4746167767735, 7531.472796904383, 7653.0, 7816.335611472861, 7850.175731548105, 6415.871682566416, 7585.506942048749, 7616.504927179715, 7837.882431763414, 7871.685132594632, 7645.617719114133, 7891.68433262686, 7976.282134607914, 7999.200079991954, 8026.558539280396, 9261.72214833556, 10918.739172855838, 11174.608888688857, 11306.604268850551, 11318.717032074264, 10634.787304254027, 10662.626808061681, 10872.891271087505, 11013.118950483782, 11168.776624467302], "unit": "score", "name": "jquery.html", "value": 8648.67475693136}, {"lowerIsBetter": false, "replicates": [1258.276491017665, 1526.4199604150424, 1559.329488320022, 1790.4002159276642, 1934.1779743608963, 7245.456590755694, 7919.643616037278, 8723.21491065804, 8726.301895848334, 8726.694565690203, 7303.817404564876, 8435.536045517494, 8708.303335733142, 8718.73843784686, 8798.736037918856, 2191.0, 2254.357508110189, 2449.3998970252223, 2459.741727118649, 2507.0, 2484.0312278211513, 2519.911803086892, 2520.5589021921182, 2526.3305224115625, 2528.4943011397704, 2475.170817776047, 2502.6120951252583, 2507.0723832182025, 2508.6989561252585, 2509.736477669846, 2415.420299128214, 2487.738787427312, 2488.6515887775727, 2488.875556222182, 2489.9128530501434, 2426.502566973784, 2444.8655323957355, 2493.9127130550523, 2494.2143224884103, 2497.600383938561, 7906.051273847118, 8844.823103537894, 8952.776180595472, 8958.910410895873, 8974.820503589892, 5034.874128146789, 5505.779768809243, 5509.807156749494, 5517.034518959166, 5518.944810551883, 3632.527771389729, 3669.94495082574, 3728.0, 3729.198222382201, 3747.9437808432895, 1042.650712011477, 1048.035807057509, 1049.3074570783322, 1097.544519024604, 1101.9889801101967, 11793.115516336224, 11960.043196544255, 11960.401979901057, 11993.760124797454, 12041.759164816742, 4895.0, 4925.088858561177, 5047.924281135786, 5052.1663925451885, 5053.0, 10340.431276279727, 10341.63804266847, 10354.0, 10354.223433242538, 10371.740706482398, 5512.283403157644, 5523.8066667666435, 5561.332640083135, 5569.470900264469, 5597.440255974451, 4905.705657660552, 5018.347614810052, 5023.447420783711, 5029.5724863386295, 5032.446430892599, 3715.442683597482, 3809.485719427897, 3957.149212919179, 3970.285348637215, 4010.859619913289, 1298.571471414431, 1306.2097431054265, 1308.3719814489098, 1316.3615646411483, 1317.617890811673, 1323.1069028405789, 1329.4017692038622, 1334.0728193905336, 1342.0408000359184, 1361.339750221142, 8204.630791614392, 8221.630026648816, 8229.711960081488, 8237.588120593946, 8261.297789687944, 1123.7640095579857, 1130.5647325779469, 1149.8677652069953, 1192.6486572730655, 1198.5385626533848, 6175.752969881154, 6202.4417802398, 6271.3415091414745, 6278.30938596754, 6295.748170073238, 9606.855897161548, 10727.892721072845, 10733.624323148651, 10842.29525080883, 10845.620403285848, 10315.535800888827, 10617.150627949746, 10699.304545204537, 10737.03366697001, 10748.570057197625, 8253.504789712637, 8258.339332853357, 8264.173582641808, 8331.166883311742, 8342.791430214293, 7719.884201737091, 7864.921350786648, 7918.802029949297, 7947.403944704055, 7948.920510794818, 9296.488693121673, 9524.809503809747, 9529.142377186086, 9624.326297159132, 9627.422354658744, 9670.274729395183, 9888.851667224853, 9972.052654997764, 10076.949615251877, 10087.89912100899, 6882.242953275036, 7498.737544186146, 7518.060242469692, 7541.2458754124145, 7589.1272503660575, 7704.19105993885, 8053.114157442559, 8250.752477425687, 8250.958745206235, 8254.628541715518, 7545.396368290633, 7670.0, 7698.0, 7827.334676552329, 7838.294553489985, 7416.6291685414435, 7507.737229196952, 7571.091469023752, 7614.733484328022, 7634.770956871303, 7680.0, 7743.341815945482, 7746.65140068687, 7752.5348479091435, 7765.301122898966, 6938.098047253825, 6956.373926346653, 7017.929820701727, 7018.859622807618, 7035.613041282574, 7111.2888711130545, 7121.715131394686, 7152.785416437515, 7155.248698886542, 7155.499115061895], "unit": "score", "name": "mootools.html", "value": 4978.826262472644}, {"lowerIsBetter": false, "replicates": [325.0670575448463, 329.881242752609, 335.1520652748546, 336.21829247000727, 339.49245877413273, 6473.44975677068, 6492.0, 6512.460140545185, 6527.347265273476, 6541.149650545422, 6416.294207637168, 6428.935710642892, 6434.935650643492, 6450.709718062687, 6451.870842641327, 4581.289900065495, 4800.255960326138, 4801.039792041588, 4806.327114204014, 4807.110684523357, 4586.678932474728, 4697.88255293617, 4723.598494127986, 4724.480307166209, 4740.691855029412, 3781.6596506314427, 3945.5659877413464, 4673.83641572545, 4675.532446755315, 4680.134175177586, 4499.842505512292, 4590.08198360326, 4611.930821037688, 4676.883077923045, 4707.082118986799, 3552.6447355264527, 3782.71629627779, 4032.334664780308, 4032.9798351008058, 4056.6551843093075, 5140.948590514085, 5477.685355514687, 5931.288245410536, 6194.194754681907, 6204.627722336629, 5324.787008519694, 5362.973185134088, 5432.809851655173, 5441.700706461143, 5447.210154527611, 5756.625819321773, 6645.4683625310345, 6774.187097548326, 6850.38346548813, 6883.793486195422, 4470.173017991649, 4475.597196252353, 4482.148391805579, 4485.9906521032835, 4494.123645889053, 5670.319561652628, 6809.808283550359, 6939.981108217941, 7170.498065135443, 7186.137663480364, 3626.3472574936236, 4711.128441238382, 4725.078609671081, 4730.905381892343, 4736.5973892219545, 4779.064478886056, 4783.258594917794, 4792.329073929653, 4796.664233503621, 4800.783964721596, 5356.598255130881, 5548.528375088163, 5552.167174923794, 5558.833235002957, 5568.443155684399, 5487.560995120461, 6790.7623233186605, 6794.558353706993, 6801.1158549388265, 6808.3532064454785, 1645.3171933647402, 1678.7146185148554, 1681.4115059729243, 1683.671684021604, 1686.376040864888, 897.6768363389175, 1090.5038207615517, 1104.917131215146, 1105.6296140792763, 1115.503600897609, 5174.741262936914, 6402.9359706403275, 6420.261669907927, 6443.6455994920725, 6445.871082578416, 7176.7846964591145, 7177.03110080143, 7179.174394944648, 7181.210066892638, 7189.35295823368, 6180.6600636965395, 6388.648624325707, 6393.808185754435, 6407.935920640827, 6413.647249401234, 3785.37541305687, 3815.6184381562175, 3816.9427458588143, 3818.8663396781535, 3821.5032045833864, 7588.344079572105, 7605.467617266738, 7606.315431611181, 7614.933909252709, 7632.427567932316, 6386.393292637192, 7186.712531498786, 7271.163816161209, 7395.334419902235, 7475.775726728207, 7315.451341149329, 7575.886361704689, 7616.162222155448, 7631.0, 7638.694452221849, 6956.686949087202, 7251.8187045324285, 7251.927480725125, 7262.913261863581, 7264.673089711081, 5707.372189059283, 7125.572465652078, 7135.429165666838, 7139.643017849191, 7149.177844547944, 7408.444366672629, 7545.358644515278, 7552.509086909334, 7564.810879728051, 7565.8108547284555, 3800.7339486235696, 3912.7847968360875, 4413.117376524772, 4472.597466228055, 4561.703489273186, 5747.540196784331, 7144.678489467882, 7153.570785752871, 7166.954044531158, 7178.138623365229, 5637.3235211774845, 6852.972054191911, 6906.8618627628175, 6915.343042411164, 6927.134108236471, 6610.933890661224, 6906.723731050903, 6909.965450172717, 6921.7231310747, 6931.306869313028, 6746.190457145174, 6753.15585551806, 6756.69594868242, 6774.4580433564215, 6786.185657721105, 6877.759278425231, 6916.273791251846, 6920.792376228721, 6932.306769323028, 6940.757073502403, 6054.9101161791305, 6124.38756124384, 6408.839779005562, 6725.730970761115, 6743.966280168568], "unit": "score", "name": "prototype.html", "value": 4992.399253571276}, {"lowerIsBetter": false, "replicates": [632.6330728177658, 698.7903628911325, 734.3501001613571, 748.6182047155949, 790.4940837863768, 13089.738205235913, 14874.405023799049, 15006.624834379147, 15030.849691503081, 15072.773908391382, 15166.848331516681, 15513.612159696013, 15513.68972620547, 15514.224288785572, 15596.986195897258, 674.7199912036499, 682.6723172877022, 828.7430896422113, 844.624142256693, 847.1613103027988, 706.5336877660745, 826.6775957376628, 828.5401602110826, 842.8230071684953, 844.2064459408167, 891.9910800892005, 895.444824208988, 895.4537731983485, 895.8253140637578, 895.8253140637578, 712.458531516049, 721.6860665610476, 863.1627321498199, 879.1647934462286, 883.9469631822111, 654.8853950558633, 656.2518728649344, 656.4092316914767, 656.5108993799602, 658.0852614865341, 14833.110013399122, 14882.10707357562, 14890.851091489054, 14899.404023839033, 14924.477643282542, 12246.755064898742, 12378.876211237863, 12600.936995315056, 12911.289879056649, 13165.341732913412, 10084.193264538893, 10090.293679442442, 10096.242781791396, 10165.0, 10886.0746836519, 3471.7743346682637, 3508.4211105167615, 3511.315293517765, 3518.6481351864863, 3587.3004764071015, 77094.0, 77195.61402192953, 78107.0, 78159.0, 78237.0, 9254.676086336945, 9372.531373431437, 9461.574229159703, 9475.384100033614, 9809.656662016938, 20161.697574536392, 20429.0, 20676.17295308201, 20682.68975965362, 20749.377518674464, 7452.590107544029, 7548.635806711895, 7607.429442791813, 7725.8454830903065, 7855.489393189425, 3971.285168669667, 4071.246819338432, 4152.896177595584, 4153.1486045360625, 4278.4865816102265, 3514.156602415453, 3547.467879817996, 3578.284343131384, 3578.964210357863, 3583.552055993001, 647.2879832184559, 657.7927952694981, 658.6640813185214, 666.4268728893148, 674.2953613473834, 520.9973950130225, 551.3439007580965, 595.532506982017, 622.4553515673786, 632.8417895526119, 8485.575721214038, 8537.74386768398, 8642.913570864337, 8661.913380866237, 8750.124987501198, 466.23304663827815, 483.20271551939584, 583.9795607153729, 613.1171113596407, 620.872721092175, 3486.0761898097026, 3647.908802279964, 3799.6306327271045, 4045.4943132108488, 4189.539150693421, 83370.74943875847, 83628.0, 84669.0, 84894.57552712197, 85127.14872851192, 73758.26241737622, 73854.0, 74375.0, 74572.25427745761, 74909.0, 64721.029184561325, 65152.67423662851, 66128.00807987884, 66188.0, 66812.33187668158, 8116.83766324682, 8185.754427367188, 8240.299574535991, 8253.257206851413, 8295.211954864279, 40105.99735006648, 40565.79717101395, 42590.78704606457, 43531.78234108809, 44679.776601116784, 56131.0, 58929.70535147297, 62282.37717622766, 62764.68617656882, 63272.0, 9764.80470390574, 10111.292209545261, 10245.692629221136, 10305.381677099398, 10530.947345263532, 11966.880331196577, 11990.760184796429, 12181.634550963485, 12489.0, 12916.547920822726, 11498.82751758741, 11646.94176529112, 11827.0, 11882.940585297018, 12362.44369003379, 10904.309831976056, 11410.828837567276, 11415.029722473682, 11628.825567616661, 12332.753344933231, 10969.670909872717, 11103.555857765921, 11252.987231149236, 11259.042981346678, 11332.830007549728, 9221.262299015929, 9250.352475326932, 9463.668771593237, 9869.210463163074, 9975.401475911469, 9069.0, 9273.979862215016, 9489.95255023748, 10044.296899216984, 10052.0], "unit": "score", "name": "yui.html", "value": 6721.47674887603}], "name": "dromaeo_css", "value": 7308.5699682934}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 107.0, 109.0, 111.0, 110.0, 111.0, 116.0, 111.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [159.0, 124.0, 149.0, 151.0, 100.0, 164.0, 169.0, 119.0, 159.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 141.1}, {"lowerIsBetter": true, "replicates": [187.0, 186.0, 186.0, 183.0, 184.0, 185.0, 185.0, 186.0, 181.0, 191.0], "unit": "score", "name": "audio-dft", "value": 185.4}, {"lowerIsBetter": true, "replicates": [73.0, 80.0, 84.0, 80.0, 73.0, 86.0, 47.0, 85.0, 69.0, 52.0], "unit": "score", "name": "audio-fft", "value": 72.9}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 126.0, 79.0, 81.0, 84.0, 106.0, 77.0, 77.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 92.9}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 83.0, 90.0, 84.0, 89.0, 84.0, 90.0, 85.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 93.0, 93.0, 100.0, 141.0, 111.0], "unit": "score", "name": "imaging-darkroom", "value": 100.9}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 86.0, 87.0, 85.0, 87.0, 86.0, 84.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.7}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 53.0, 54.0, 55.0, 54.0, 55.0, 63.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [65.0, 61.0, 72.0, 73.0, 69.0, 65.0, 65.0, 66.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 82.0, 82.0, 95.0, 83.0, 82.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [111.0, 144.0, 133.0, 132.0, 114.0, 124.0, 139.0, 135.0, 127.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.1}, {"lowerIsBetter": true, "replicates": [138.0, 157.0, 188.0, 134.0, 137.0, 124.0, 138.0, 137.0, 137.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.6}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 83.0, 96.0, 95.0, 71.0, 66.0, 67.0, 65.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.5}], "name": "kraken", "value": 1426.2999999999997}]} 03:08:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1426.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7308.57"}}} 03:08:48 INFO - Return code: 0 03:08:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:08:49 INFO - # TBPL SUCCESS # 03:08:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:08:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:08:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:08:49 INFO - 2016-02-10 03:08:49.042 screenresolution[1687:9952] starting screenresolution argv=screenresolution get 03:08:49 INFO - 2016-02-10 03:08:49.045 screenresolution[1687:9952] Display 0: 1600x1200x32@60 03:08:49 INFO - 2016-02-10 03:08:49.051 screenresolution[1688:9955] starting screenresolution argv=screenresolution list 03:08:49 INFO - Available Modes on Display 0 03:08:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:08:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:08:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:08:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:08:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:08:49 INFO - Intel Iris: 03:08:49 INFO - Chipset Model: Intel Iris 03:08:49 INFO - Type: GPU 03:08:49 INFO - Bus: Built-In 03:08:49 INFO - VRAM (Dynamic, Max): 1536 MB 03:08:49 INFO - Vendor: Intel (0x8086) 03:08:49 INFO - Device ID: 0x0a2e 03:08:49 INFO - Revision ID: 0x0009 03:08:49 INFO - Displays: 03:08:49 INFO - Display: 03:08:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:08:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:08:49 INFO - Display Serial Number: 1600x1200 60 03:08:49 INFO - Main Display: Yes 03:08:49 INFO - Mirror: Off 03:08:49 INFO - Online: Yes 03:08:49 INFO - Rotation: Supported 03:08:49 INFO - Return code: 0 03:08:49 INFO - Running post-action listener: _resource_record_post_action 03:08:49 INFO - Running post-run listener: _resource_record_post_run 03:08:50 INFO - Total resource usage - Wall time: 1210s; CPU: 52.0%; Read bytes: 39044608; Write bytes: 708238848; Read time: 420; Write time: 2443 03:08:50 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 395514368; Write bytes: 389228032; Read time: 30104; Write time: 750 03:08:50 INFO - run-tests - Wall time: 1176s; CPU: 52.0%; Read bytes: 37131776; Write bytes: 299124736; Read time: 400; Write time: 1652 03:08:50 INFO - Running post-run listener: _upload_blobber_files 03:08:50 INFO - Blob upload gear active. 03:08:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:08:50 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 03:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:08:50 INFO - (blobuploader) - INFO - Open directory for files ... 03:08:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:08:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:08:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:08:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:08:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:08:51 INFO - (blobuploader) - INFO - Done attempting. 03:08:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:08:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:08:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:08:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:08:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:08:53 INFO - (blobuploader) - INFO - Done attempting. 03:08:53 INFO - (blobuploader) - INFO - Iteration through files over. 03:08:53 INFO - Return code: 0 03:08:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:08:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:08:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c1861404a487b37c9b40eb3b37910d8b90caa926246ca36e6b097d888b3b417ca549684cf466e03df470a739bb4cea390a44a96cea094d56c007bbf030a87b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40be988e49712ed2f2a288615b0ec9b4a3cbb9458ddbdf3e713d4856f3173eccb11f54550f268bd6c13b4508af0c0ef709328a1e8ffe035d586f06e3f9c6b0b7"} 03:08:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:08:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:08:53 INFO - Contents: 03:08:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c1861404a487b37c9b40eb3b37910d8b90caa926246ca36e6b097d888b3b417ca549684cf466e03df470a739bb4cea390a44a96cea094d56c007bbf030a87b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40be988e49712ed2f2a288615b0ec9b4a3cbb9458ddbdf3e713d4856f3173eccb11f54550f268bd6c13b4508af0c0ef709328a1e8ffe035d586f06e3f9c6b0b7"} 03:08:53 INFO - Running post-run listener: copy_logs_to_upload_dir 03:08:53 INFO - Copying logs to upload dir... 03:08:53 INFO - mkdir: /builds/slave/test/build/upload/logs 03:08:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.281736 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-10 03:08:53.150292) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 03:08:53.153878) ========= 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.1qR9pvRQSO/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.tf2PjMuCka/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c1861404a487b37c9b40eb3b37910d8b90caa926246ca36e6b097d888b3b417ca549684cf466e03df470a739bb4cea390a44a96cea094d56c007bbf030a87b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40be988e49712ed2f2a288615b0ec9b4a3cbb9458ddbdf3e713d4856f3173eccb11f54550f268bd6c13b4508af0c0ef709328a1e8ffe035d586f06e3f9c6b0b7"} build_url:https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010950 build_url: 'https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c1861404a487b37c9b40eb3b37910d8b90caa926246ca36e6b097d888b3b417ca549684cf466e03df470a739bb4cea390a44a96cea094d56c007bbf030a87b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40be988e49712ed2f2a288615b0ec9b4a3cbb9458ddbdf3e713d4856f3173eccb11f54550f268bd6c13b4508af0c0ef709328a1e8ffe035d586f06e3f9c6b0b7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 03:08:53.186844) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 03:08:53.187524) ========= 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.1qR9pvRQSO/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.tf2PjMuCka/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005096 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 03:08:53.238304) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 03:08:53.238650) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 03:08:53.239374) ========= ========= Total master_lag: 0.24 =========