builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0024 starttime: 1457370526.11 results: success (0) buildid: 20160307062903 builduid: 778606b1b6314f8dbf2a196a3ebd0e49 revision: be593a64d7c6a826260514fe758ef32a6ee580f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:46.108273) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:46.108673) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:46.108969) ========= 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.P0H1CagNt4/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.fFUD3moqd1/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.005699 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:46.201339) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2016-03-07 09:08:46.201744) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2016-03-07 09:08:52.658769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:52.659027) ========= 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.P0H1CagNt4/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.fFUD3moqd1/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.005809 ========= master_lag: 0.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:52.854664) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:52.854952) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:52.855287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:52.855563) ========= 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.P0H1CagNt4/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.fFUD3moqd1/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-07 09:08:52-- 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% 147M=0s 2016-03-07 09:08:53 (147 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.476013 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:53.506746) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:53.507030) ========= 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.P0H1CagNt4/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.fFUD3moqd1/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.026624 ========= master_lag: 0.36 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:53.894690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-07 09:08:53.895007) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev be593a64d7c6a826260514fe758ef32a6ee580f7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev be593a64d7c6a826260514fe758ef32a6ee580f7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P0H1CagNt4/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.fFUD3moqd1/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-07 09:08:53,997 truncating revision to first 12 chars 2016-03-07 09:08:53,998 Setting DEBUG logging. 2016-03-07 09:08:53,998 attempt 1/10 2016-03-07 09:08:53,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/be593a64d7c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 09:08:54,675 unpacking tar archive at: mozilla-central-be593a64d7c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.927321 ========= master_lag: 0.35 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-07 09:08:55.176374) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:55.176682) ========= echo be593a64d7c6a826260514fe758ef32a6ee580f7 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'be593a64d7c6a826260514fe758ef32a6ee580f7'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P0H1CagNt4/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.fFUD3moqd1/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 be593a64d7c6a826260514fe758ef32a6ee580f7 program finished with exit code 0 elapsedTime=0.005788 script_repo_revision: 'be593a64d7c6a826260514fe758ef32a6ee580f7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:55.232245) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:55.232535) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:55.873602) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-03-07 09:08:55.874049) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P0H1CagNt4/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.fFUD3moqd1/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 09:08:56 INFO - MultiFileLogger online at 20160307 09:08:56 in /builds/slave/test 09:08:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:08:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:08:56 INFO - {'append_to_log': False, 09:08:56 INFO - 'base_work_dir': '/builds/slave/test', 09:08:56 INFO - 'blob_upload_branch': 'Firefox', 09:08:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:08:56 INFO - 'branch': 'Firefox', 09:08:56 INFO - 'buildbot_json_path': 'buildprops.json', 09:08:56 INFO - 'config_files': ('talos/mac_config.py',), 09:08:56 INFO - 'default_actions': ('clobber', 09:08:56 INFO - 'read-buildbot-config', 09:08:56 INFO - 'download-and-extract', 09:08:56 INFO - 'populate-webroot', 09:08:56 INFO - 'create-virtualenv', 09:08:56 INFO - 'install', 09:08:56 INFO - 'run-tests'), 09:08:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:08:56 INFO - 'download_minidump_stackwalk': True, 09:08:56 INFO - 'download_symbols': 'ondemand', 09:08:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:08:56 INFO - 'tooltool.py': '/tools/tooltool.py', 09:08:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:08:56 INFO - '/tools/misc-python/virtualenv.py')}, 09:08:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:08:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:08:56 INFO - 'installer_path': 'installer.exe', 09:08:56 INFO - 'log_level': 'info', 09:08:56 INFO - 'log_name': 'talos', 09:08:56 INFO - 'log_to_console': True, 09:08:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:08:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:08:56 INFO - 'opt_config_files': (), 09:08:56 INFO - 'pip_index': False, 09:08:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:08:56 INFO - 'cmd': ('bash', 09:08:56 INFO - '-c', 09:08:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:08:56 INFO - 'enabled': True, 09:08:56 INFO - 'halt_on_failure': False, 09:08:56 INFO - 'name': 'check_screen_resolution'},), 09:08:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:08:56 INFO - 'cmd': ('bash', 09:08:56 INFO - '-c', 09:08:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:08:56 INFO - 'enabled': True, 09:08:56 INFO - 'halt_on_failure': False, 09:08:56 INFO - 'name': 'check_screen_resolution'},), 09:08:56 INFO - 'run_cmd_checks_enabled': True, 09:08:56 INFO - 'sps_profile': False, 09:08:56 INFO - 'sps_profile_interval': 0, 09:08:56 INFO - 'suite': 'dromaeojs', 09:08:56 INFO - 'system_bits': '32', 09:08:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:08:56 INFO - 'title': 't-yosemite-r7-0024', 09:08:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:08:56 INFO - 'use_talos_json': True, 09:08:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:08:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:08:56 INFO - 'work_dir': 'build'} 09:08:56 INFO - ##### 09:08:56 INFO - ##### Running clobber step. 09:08:56 INFO - ##### 09:08:56 INFO - Running pre-action listener: _resource_record_pre_action 09:08:56 INFO - Running main action method: clobber 09:08:56 INFO - rmtree: /builds/slave/test/build 09:08:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:08:57 INFO - Running post-action listener: _resource_record_post_action 09:08:57 INFO - ##### 09:08:57 INFO - ##### Running read-buildbot-config step. 09:08:57 INFO - ##### 09:08:57 INFO - Running pre-action listener: _resource_record_pre_action 09:08:57 INFO - Running main action method: read_buildbot_config 09:08:57 INFO - Using buildbot properties: 09:08:57 INFO - { 09:08:57 INFO - "project": "", 09:08:57 INFO - "product": "firefox", 09:08:57 INFO - "script_repo_revision": "production", 09:08:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:08:57 INFO - "repository": "", 09:08:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:08:57 INFO - "buildid": "20160307062903", 09:08:57 INFO - "stage_platform": "macosx64", 09:08:57 INFO - "basedir": "/builds/slave/test", 09:08:57 INFO - "nightly_build": "True", 09:08:57 INFO - "buildnumber": 155, 09:08:57 INFO - "slavename": "t-yosemite-r7-0024", 09:08:57 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:08:57 INFO - "platform": "yosemite_r7", 09:08:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:08:57 INFO - "branch": "mozilla-central", 09:08:57 INFO - "repo_path": "mozilla-central", 09:08:57 INFO - "revision": "be593a64d7c6a826260514fe758ef32a6ee580f7", 09:08:57 INFO - "pgo_build": "False", 09:08:57 INFO - "builduid": "778606b1b6314f8dbf2a196a3ebd0e49", 09:08:57 INFO - "slavebuilddir": "test" 09:08:57 INFO - } 09:08:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 09:08:57 INFO - Running post-action listener: _resource_record_post_action 09:08:57 INFO - ##### 09:08:57 INFO - ##### Running download-and-extract step. 09:08:57 INFO - ##### 09:08:57 INFO - Running pre-action listener: _resource_record_pre_action 09:08:57 INFO - Running main action method: download_and_extract 09:08:57 INFO - mkdir: /builds/slave/test/build/tests 09:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:57 INFO - https://queue.taskcluster.net/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:08:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:08:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:08:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:08:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 09:09:02 INFO - Downloaded 1277 bytes. 09:09:02 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:09:02 INFO - Using the following test package requirements: 09:09:02 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:09:02 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:09:02 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:09:02 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:09:02 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:09:02 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:09:02 INFO - u'jsshell-mac.zip'], 09:09:02 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:09:02 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:09:02 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:09:02 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:09:02 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:09:02 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:09:02 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:09:02 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:09:02 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:09:02 INFO - u'webapprt': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:09:02 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:09:02 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:09:02 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:02 INFO - https://queue.taskcluster.net/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:09:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:09:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:09:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:09:09 INFO - Downloaded 17866522 bytes. 09:09:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:09:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:09:12 INFO - Return code: 0 09:09:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:12 INFO - https://queue.taskcluster.net/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:09:13 INFO - Downloaded 17866522 bytes. 09:09:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:09:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:09:17 INFO - Return code: 0 09:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:17 INFO - https://queue.taskcluster.net/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:09:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:09:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:09:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:09:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:09:18 INFO - Downloaded 10845161 bytes. 09:09:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:09:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:09:18 INFO - Return code: 0 09:09:18 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')]} 09:09:18 INFO - https://queue.taskcluster.net/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:09:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:09:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:09:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:09:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 09:09:22 INFO - Downloaded 111115726 bytes. 09:09:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:09:22 INFO - mkdir: /builds/slave/test/properties 09:09:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:09:22 INFO - Writing to file /builds/slave/test/properties/build_url 09:09:22 INFO - Contents: 09:09:22 INFO - build_url:https://queue.taskcluster.net/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:09:23 INFO - Running post-action listener: _resource_record_post_action 09:09:23 INFO - Running post-action listener: set_extra_try_arguments 09:09:23 INFO - ##### 09:09:23 INFO - ##### Running populate-webroot step. 09:09:23 INFO - ##### 09:09:23 INFO - Running pre-action listener: _resource_record_pre_action 09:09:23 INFO - Running main action method: populate_webroot 09:09:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:09:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:09:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:09:23 INFO - '--tppagecycles', 09:09:23 INFO - '7'], 09:09:23 INFO - 'tests': ['tsvgm']}}, 09:09:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:09:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:09:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:09:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:09:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:09:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:09:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:09:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:23 INFO - 'talos_options': ['--e10s'], 09:09:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:09:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:23 INFO - 'tests': ['damp', 'tps']}, 09:09:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:23 INFO - 'talos_options': ['--e10s'], 09:09:23 INFO - 'tests': ['damp', 'tps']}, 09:09:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:09:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:09:23 INFO - 'other': {'tests': ['a11yr', 09:09:23 INFO - 'ts_paint', 09:09:23 INFO - 'tpaint', 09:09:23 INFO - 'sessionrestore', 09:09:23 INFO - 'sessionrestore_no_auto_restore', 09:09:23 INFO - 'tabpaint']}, 09:09:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:09:23 INFO - 'tests': ['a11yr', 09:09:23 INFO - 'ts_paint', 09:09:23 INFO - 'tpaint', 09:09:23 INFO - 'sessionrestore', 09:09:23 INFO - 'sessionrestore_no_auto_restore', 09:09:23 INFO - 'tabpaint']}, 09:09:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:09:23 INFO - 'tests': ['a11yr', 09:09:23 INFO - 'ts_paint', 09:09:23 INFO - 'tpaint', 09:09:23 INFO - 'sessionrestore', 09:09:23 INFO - 'sessionrestore_no_auto_restore', 09:09:23 INFO - 'tabpaint']}, 09:09:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:09:23 INFO - 'tests': ['a11yr', 09:09:23 INFO - 'ts_paint', 09:09:23 INFO - 'tpaint', 09:09:23 INFO - 'sessionrestore', 09:09:23 INFO - 'sessionrestore_no_auto_restore', 09:09:23 INFO - 'tabpaint']}, 09:09:23 INFO - 'other_l64': {'tests': ['a11yr', 09:09:23 INFO - 'ts_paint', 09:09:23 INFO - 'tpaint', 09:09:23 INFO - 'sessionrestore', 09:09:23 INFO - 'sessionrestore_no_auto_restore', 09:09:23 INFO - 'tabpaint']}, 09:09:23 INFO - 'other_nol64': {'tests': ['a11yr', 09:09:23 INFO - 'ts_paint', 09:09:23 INFO - 'tpaint', 09:09:23 INFO - 'sessionrestore', 09:09:23 INFO - 'sessionrestore_no_auto_restore', 09:09:23 INFO - 'tabpaint']}, 09:09:23 INFO - 'svgr': {'tests': ['tsvgx', 09:09:23 INFO - 'tsvgr_opacity', 09:09:23 INFO - 'tart', 09:09:23 INFO - 'tscrollx', 09:09:23 INFO - 'cart']}, 09:09:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:09:23 INFO - 'tests': ['tsvgx', 09:09:23 INFO - 'tsvgr_opacity', 09:09:23 INFO - 'tart', 09:09:23 INFO - 'tscrollx', 09:09:23 INFO - 'cart']}, 09:09:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:23 INFO - 'tests': ['tp5o']}, 09:09:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:23 INFO - 'talos_options': ['--e10s'], 09:09:23 INFO - 'tests': ['tp5o']}, 09:09:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:23 INFO - 'talos_options': ['--xperf_path', 09:09:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:09:23 INFO - 'tests': ['tp5n']}, 09:09:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:23 INFO - 'talos_options': ['--e10s', 09:09:23 INFO - '--xperf_path', 09:09:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:09:23 INFO - 'tests': ['tp5n']}}, 09:09:23 INFO - 'talos.zip': {'path': '', 09:09:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:09:23 INFO - Running post-action listener: _resource_record_post_action 09:09:23 INFO - ##### 09:09:23 INFO - ##### Running create-virtualenv step. 09:09:23 INFO - ##### 09:09:23 INFO - Running pre-action listener: _resource_record_pre_action 09:09:23 INFO - Running main action method: create_virtualenv 09:09:23 INFO - Creating virtualenv /builds/slave/test/build/venv 09:09:23 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 09:09:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:09:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:09:23 INFO - Using real prefix '/tools/python27' 09:09:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:09:24 INFO - Installing distribute.............................................................................................................................................................................................done. 09:09:26 INFO - Installing pip.................done. 09:09:26 INFO - Return code: 0 09:09:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:09:26 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')]} 09:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:26 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')]} 09:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:26 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 0x10a0faa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfe8ca53e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f9ed30>, '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 0x109dc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f95b20>, '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.P0H1CagNt4/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.fFUD3moqd1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 09:09:26 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 09:09:26 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 09:09:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0H1CagNt4/Render', 09:09:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:26 INFO - 'HOME': '/Users/cltbld', 09:09:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:26 INFO - 'LOGNAME': 'cltbld', 09:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:26 INFO - 'MOZ_NO_REMOTE': '1', 09:09:26 INFO - 'NO_EM_RESTART': '1', 09:09:26 INFO - 'PAGER': '/bin/cat', 09:09:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:26 INFO - 'PWD': '/builds/slave/test', 09:09:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:26 INFO - 'SHELL': '/bin/bash', 09:09:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFUD3moqd1/Listeners', 09:09:26 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:09:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:26 INFO - 'USER': 'cltbld', 09:09:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:26 INFO - 'XPC_FLAGS': '0x0', 09:09:26 INFO - 'XPC_SERVICE_NAME': '0', 09:09:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:27 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 09:09:27 INFO - Cleaning up... 09:09:27 INFO - Return code: 0 09:09:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:27 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 0x10a0faa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfe8ca53e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f9ed30>, '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 0x109dc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f95b20>, '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.P0H1CagNt4/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.fFUD3moqd1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 09:09:27 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 09:09:27 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 09:09:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0H1CagNt4/Render', 09:09:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:27 INFO - 'HOME': '/Users/cltbld', 09:09:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:27 INFO - 'LOGNAME': 'cltbld', 09:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:27 INFO - 'MOZ_NO_REMOTE': '1', 09:09:27 INFO - 'NO_EM_RESTART': '1', 09:09:27 INFO - 'PAGER': '/bin/cat', 09:09:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:27 INFO - 'PWD': '/builds/slave/test', 09:09:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:27 INFO - 'SHELL': '/bin/bash', 09:09:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFUD3moqd1/Listeners', 09:09:27 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:09:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:27 INFO - 'USER': 'cltbld', 09:09:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:27 INFO - 'XPC_FLAGS': '0x0', 09:09:27 INFO - 'XPC_SERVICE_NAME': '0', 09:09:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:27 INFO - Downloading/unpacking psutil>=0.7.1 09:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:09:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:30 INFO - Installing collected packages: psutil 09:09:30 INFO - Running setup.py install for psutil 09:09:30 INFO - building 'psutil._psutil_osx' extension 09:09:30 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 09:09:31 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 09:09:31 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 09:09:31 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 09:09:31 INFO - building 'psutil._psutil_posix' extension 09:09:31 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 09:09:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:09:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:09:31 INFO - ^ 09:09:31 INFO - 1 warning generated. 09:09:31 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 09:09:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:31 INFO - Successfully installed psutil 09:09:31 INFO - Cleaning up... 09:09:32 INFO - Return code: 0 09:09:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a0faa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfe8ca53e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f9ed30>, '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 0x109dc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f95b20>, '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.P0H1CagNt4/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.fFUD3moqd1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 09:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:09:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0H1CagNt4/Render', 09:09:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:32 INFO - 'HOME': '/Users/cltbld', 09:09:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:32 INFO - 'LOGNAME': 'cltbld', 09:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:32 INFO - 'MOZ_NO_REMOTE': '1', 09:09:32 INFO - 'NO_EM_RESTART': '1', 09:09:32 INFO - 'PAGER': '/bin/cat', 09:09:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:32 INFO - 'PWD': '/builds/slave/test', 09:09:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:32 INFO - 'SHELL': '/bin/bash', 09:09:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFUD3moqd1/Listeners', 09:09:32 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:09:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:32 INFO - 'USER': 'cltbld', 09:09:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:32 INFO - 'XPC_FLAGS': '0x0', 09:09:32 INFO - 'XPC_SERVICE_NAME': '0', 09:09:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:09:32 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 09:09:32 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 09:09:32 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 09:09:32 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 09:09:32 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 09:09:32 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 09:09:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:09:34 INFO - Installing collected packages: mozsystemmonitor 09:09:34 INFO - Running setup.py install for mozsystemmonitor 09:09:34 INFO - Successfully installed mozsystemmonitor 09:09:34 INFO - Cleaning up... 09:09:34 INFO - Return code: 0 09:09:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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', '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 0x10a0faa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfe8ca53e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f9ed30>, '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 0x109dc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f95b20>, '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.P0H1CagNt4/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.fFUD3moqd1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 09:09: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:09: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 blobuploader==1.2.4 09:09:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0H1CagNt4/Render', 09:09:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:34 INFO - 'HOME': '/Users/cltbld', 09:09:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:34 INFO - 'LOGNAME': 'cltbld', 09:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:34 INFO - 'MOZ_NO_REMOTE': '1', 09:09:34 INFO - 'NO_EM_RESTART': '1', 09:09:34 INFO - 'PAGER': '/bin/cat', 09:09:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:34 INFO - 'PWD': '/builds/slave/test', 09:09:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:34 INFO - 'SHELL': '/bin/bash', 09:09:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFUD3moqd1/Listeners', 09:09:34 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:09:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:34 INFO - 'USER': 'cltbld', 09:09:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:34 INFO - 'XPC_FLAGS': '0x0', 09:09:34 INFO - 'XPC_SERVICE_NAME': '0', 09:09:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:35 INFO - Downloading/unpacking blobuploader==1.2.4 09:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:37 INFO - Downloading blobuploader-1.2.4.tar.gz 09:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:09:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:09:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:38 INFO - Downloading docopt-0.6.1.tar.gz 09:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:09:38 INFO - Installing collected packages: blobuploader, requests, docopt 09:09:38 INFO - Running setup.py install for blobuploader 09:09:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:09:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:09:38 INFO - Running setup.py install for requests 09:09:39 INFO - Running setup.py install for docopt 09:09:39 INFO - Successfully installed blobuploader requests docopt 09:09:39 INFO - Cleaning up... 09:09:39 INFO - Return code: 0 09:09:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:39 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')]} 09:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:39 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')]} 09:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:39 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 0x10a0faa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfe8ca53e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f9ed30>, '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 0x109dc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f95b20>, '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.P0H1CagNt4/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.fFUD3moqd1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 09:09:39 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 09:09:39 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 09:09:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0H1CagNt4/Render', 09:09:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:39 INFO - 'HOME': '/Users/cltbld', 09:09:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:39 INFO - 'LOGNAME': 'cltbld', 09:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:39 INFO - 'MOZ_NO_REMOTE': '1', 09:09:39 INFO - 'NO_EM_RESTART': '1', 09:09:39 INFO - 'PAGER': '/bin/cat', 09:09:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:39 INFO - 'PWD': '/builds/slave/test', 09:09:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:39 INFO - 'SHELL': '/bin/bash', 09:09:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFUD3moqd1/Listeners', 09:09:39 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:09:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:39 INFO - 'USER': 'cltbld', 09:09:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:39 INFO - 'XPC_FLAGS': '0x0', 09:09:39 INFO - 'XPC_SERVICE_NAME': '0', 09:09:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:39 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-pfsFyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:39 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Aw0pAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:40 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Z2sC2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:40 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-q6XPQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:40 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-niE_hZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:40 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-iYt2fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:40 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-HjQthC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:40 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-ed5FSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:40 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-C6fgIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:40 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-5vv0rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:40 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-ge0xRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:40 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-oHpdO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:41 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-fu5njv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:41 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-JQfjIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:41 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-l3ivmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:41 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-TBvevf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:41 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-W7_VLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:09:41 INFO - Running setup.py install for manifestparser 09:09:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:09:41 INFO - Running setup.py install for mozcrash 09:09:41 INFO - Running setup.py install for mozdebug 09:09:42 INFO - Running setup.py install for mozdevice 09:09:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:09:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:09:42 INFO - Running setup.py install for mozfile 09:09:42 INFO - Running setup.py install for mozhttpd 09:09:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:09:42 INFO - Running setup.py install for mozinfo 09:09:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:09:42 INFO - Running setup.py install for mozInstall 09:09:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:09:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:09:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:09:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:09:42 INFO - Running setup.py install for mozleak 09:09:42 INFO - Running setup.py install for mozlog 09:09:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:09:43 INFO - Running setup.py install for moznetwork 09:09:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:09:43 INFO - Running setup.py install for mozprocess 09:09:43 INFO - Running setup.py install for mozprofile 09:09:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:09:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:09:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:09:43 INFO - Running setup.py install for mozrunner 09:09:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:09:43 INFO - Running setup.py install for mozscreenshot 09:09:43 INFO - Running setup.py install for moztest 09:09:44 INFO - Running setup.py install for mozversion 09:09:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:09:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:09:44 INFO - Cleaning up... 09:09:44 INFO - Return code: 0 09:09:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:44 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 0x10a0faa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfe8ca53e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f9ed30>, '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 0x109dc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f95b20>, '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.P0H1CagNt4/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.fFUD3moqd1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 09:09:44 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 09:09:44 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 09:09:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0H1CagNt4/Render', 09:09:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:44 INFO - 'HOME': '/Users/cltbld', 09:09:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:44 INFO - 'LOGNAME': 'cltbld', 09:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:44 INFO - 'MOZ_NO_REMOTE': '1', 09:09:44 INFO - 'NO_EM_RESTART': '1', 09:09:44 INFO - 'PAGER': '/bin/cat', 09:09:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:44 INFO - 'PWD': '/builds/slave/test', 09:09:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:44 INFO - 'SHELL': '/bin/bash', 09:09:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFUD3moqd1/Listeners', 09:09:44 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:09:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:44 INFO - 'USER': 'cltbld', 09:09:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:44 INFO - 'XPC_FLAGS': '0x0', 09:09:44 INFO - 'XPC_SERVICE_NAME': '0', 09:09:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:44 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-4moEy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:44 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)) 09:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:44 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-BT8MoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:44 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-IEvbAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:44 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)) 09:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:44 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-fefjB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:44 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)) 09:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:44 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-o0XNnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:45 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)) 09:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-H1eOLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:45 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)) 09:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-1wUYeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:45 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)) 09:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-ZLiiIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:45 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)) 09:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-mcxn7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:45 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)) 09:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-3uLlFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:45 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)) 09:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-VhDWjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:45 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)) 09:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-fcoRzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:45 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)) 09:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-hmoCkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:45 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)) 09:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-ZMHtTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:46 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)) 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:46 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-aoQUCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:46 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)) 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:46 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-LsnLO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:46 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)) 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:46 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Yda1K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:46 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)) 09:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:09:46 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)) 09:09:46 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)) 09:09:46 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)) 09:09:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:09:46 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 09:09:46 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 09:09:46 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 09:09:46 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 09:09:46 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 09:09:46 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 09:09:48 INFO - Downloading blessings-1.6.tar.gz 09:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:09:48 INFO - Installing collected packages: blessings 09:09:48 INFO - Running setup.py install for blessings 09:09:48 INFO - Successfully installed blessings 09:09:48 INFO - Cleaning up... 09:09:49 INFO - Return code: 0 09:09:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:49 INFO - Reading from file tmpfile_stdout 09:09:49 INFO - Current package versions: 09:09:49 INFO - blessings == 1.6 09:09:49 INFO - blobuploader == 1.2.4 09:09:49 INFO - docopt == 0.6.1 09:09:49 INFO - manifestparser == 1.1 09:09:49 INFO - mozInstall == 1.12 09:09:49 INFO - mozcrash == 0.17 09:09:49 INFO - mozdebug == 0.1 09:09:49 INFO - mozdevice == 0.48 09:09:49 INFO - mozfile == 1.2 09:09:49 INFO - mozhttpd == 0.7 09:09:49 INFO - mozinfo == 0.9 09:09:49 INFO - mozleak == 0.1 09:09:49 INFO - mozlog == 3.1 09:09:49 INFO - moznetwork == 0.27 09:09:49 INFO - mozprocess == 0.22 09:09:49 INFO - mozprofile == 0.28 09:09:49 INFO - mozrunner == 6.11 09:09:49 INFO - mozscreenshot == 0.1 09:09:49 INFO - mozsystemmonitor == 0.0 09:09:49 INFO - moztest == 0.7 09:09:49 INFO - mozversion == 1.4 09:09:49 INFO - psutil == 3.1.1 09:09:49 INFO - requests == 1.2.3 09:09:49 INFO - wsgiref == 0.1.2 09:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:49 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 0x10a0faa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfe8ca53e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f9ed30>, '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 0x109dc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f95b20>, '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.P0H1CagNt4/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.fFUD3moqd1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 09:09:49 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 09:09:49 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 09:09:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0H1CagNt4/Render', 09:09:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:49 INFO - 'HOME': '/Users/cltbld', 09:09:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:49 INFO - 'LOGNAME': 'cltbld', 09:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:49 INFO - 'MOZ_NO_REMOTE': '1', 09:09:49 INFO - 'NO_EM_RESTART': '1', 09:09:49 INFO - 'PAGER': '/bin/cat', 09:09:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:49 INFO - 'PWD': '/builds/slave/test', 09:09:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:49 INFO - 'SHELL': '/bin/bash', 09:09:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFUD3moqd1/Listeners', 09:09:49 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:09:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:49 INFO - 'USER': 'cltbld', 09:09:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:49 INFO - 'XPC_FLAGS': '0x0', 09:09:49 INFO - 'XPC_SERVICE_NAME': '0', 09:09:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:49 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)) 09:09:49 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)) 09:09:49 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)) 09:09:49 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)) 09:09:49 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)) 09:09:49 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)) 09:09:49 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)) 09:09:49 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)) 09:09:49 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)) 09:09:49 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)) 09:09:49 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)) 09:09:49 INFO - Cleaning up... 09:09:49 INFO - Return code: 0 09:09:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:49 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 0x10a0faa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfe8ca53e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f9ed30>, '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 0x109dc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f95b20>, '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.P0H1CagNt4/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.fFUD3moqd1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 09:09:49 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 09:09:49 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 09:09:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0H1CagNt4/Render', 09:09:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:49 INFO - 'HOME': '/Users/cltbld', 09:09:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:49 INFO - 'LOGNAME': 'cltbld', 09:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:49 INFO - 'MOZ_NO_REMOTE': '1', 09:09:49 INFO - 'NO_EM_RESTART': '1', 09:09:49 INFO - 'PAGER': '/bin/cat', 09:09:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:49 INFO - 'PWD': '/builds/slave/test', 09:09:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:49 INFO - 'SHELL': '/bin/bash', 09:09:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFUD3moqd1/Listeners', 09:09:49 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:09:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:49 INFO - 'USER': 'cltbld', 09:09:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:49 INFO - 'XPC_FLAGS': '0x0', 09:09:49 INFO - 'XPC_SERVICE_NAME': '0', 09:09:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:49 INFO - Downloading/unpacking jsonschema 09:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:09:52 INFO - Downloading/unpacking functools32 (from jsonschema) 09:09:52 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 09:09:52 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 09:09:52 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 09:09:52 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 09:09:52 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 09:09:52 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 09:09:52 INFO - Downloading functools32-3.2.3-2.tar.gz 09:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:09:52 INFO - warning: no files found matching '*.txt' 09:09:52 INFO - no previously-included directories found matching 'build' 09:09:52 INFO - no previously-included directories found matching 'dist' 09:09:52 INFO - no previously-included directories found matching '.git*' 09:09:52 INFO - Installing collected packages: jsonschema, functools32 09:09:52 INFO - Running setup.py install for functools32 09:09:52 INFO - warning: no files found matching '*.txt' 09:09:52 INFO - no previously-included directories found matching 'build' 09:09:52 INFO - no previously-included directories found matching 'dist' 09:09:52 INFO - no previously-included directories found matching '.git*' 09:09:52 INFO - Successfully installed jsonschema functools32 09:09:52 INFO - Cleaning up... 09:09:52 INFO - Return code: 0 09:09:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:09:52 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')]} 09:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:52 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')]} 09:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:52 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 0x10a0faa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfe8ca53e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f9ed30>, '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 0x109dc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f95b20>, '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.P0H1CagNt4/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.fFUD3moqd1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 09:09:52 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 09:09:52 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 09:09:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0H1CagNt4/Render', 09:09:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:52 INFO - 'HOME': '/Users/cltbld', 09:09:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:52 INFO - 'LOGNAME': 'cltbld', 09:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:52 INFO - 'MOZ_NO_REMOTE': '1', 09:09:52 INFO - 'NO_EM_RESTART': '1', 09:09:52 INFO - 'PAGER': '/bin/cat', 09:09:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:52 INFO - 'PWD': '/builds/slave/test', 09:09:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:52 INFO - 'SHELL': '/bin/bash', 09:09:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFUD3moqd1/Listeners', 09:09:52 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:09:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:52 INFO - 'USER': 'cltbld', 09:09:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:52 INFO - 'XPC_FLAGS': '0x0', 09:09:52 INFO - 'XPC_SERVICE_NAME': '0', 09:09:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:53 INFO - Downloading/unpacking flake8 09:09:53 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 09:09:53 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 09:09:53 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 09:09:53 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 09:09:53 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 09:09:53 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 09:09:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:09:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:09:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:09:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:09:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:09:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:09:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:09:56 INFO - no previously-included directories found matching 'docs/_build' 09:09:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:09:56 INFO - Running setup.py install for pep8 09:09:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:09:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:09:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:09:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:09:56 INFO - no previously-included directories found matching 'docs/_build' 09:09:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:09:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:09:56 INFO - Cleaning up... 09:09:57 INFO - Return code: 0 09:09:57 INFO - Running post-action listener: _resource_record_post_action 09:09:57 INFO - Running post-action listener: _start_resource_monitoring 09:09:57 INFO - Starting resource monitoring. 09:09:57 INFO - ##### 09:09:57 INFO - ##### Running install step. 09:09:57 INFO - ##### 09:09:57 INFO - Running pre-action listener: _resource_record_pre_action 09:09:57 INFO - Running main action method: install 09:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:57 INFO - Reading from file tmpfile_stdout 09:09:57 INFO - Detecting whether we're running mozinstall >=1.0... 09:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:09:57 INFO - Reading from file tmpfile_stdout 09:09:57 INFO - Output received: 09:09:57 INFO - Usage: mozinstall [options] installer 09:09:57 INFO - Options: 09:09:57 INFO - -h, --help show this help message and exit 09:09:57 INFO - -d DEST, --destination=DEST 09:09:57 INFO - Directory to install application into. [default: 09:09:57 INFO - "/builds/slave/test"] 09:09:57 INFO - --app=APP Application being installed. [default: firefox] 09:09:57 INFO - mkdir: /builds/slave/test/build/application 09:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:10:31 INFO - Reading from file tmpfile_stdout 09:10:31 INFO - Output received: 09:10:31 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 09:10:31 INFO - Running post-action listener: _resource_record_post_action 09:10:31 INFO - ##### 09:10:31 INFO - ##### Running run-tests step. 09:10:31 INFO - ##### 09:10:31 INFO - Running pre-action listener: _resource_record_pre_action 09:10:31 INFO - Running main action method: run_tests 09:10:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:10:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:10:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:10:31 INFO - 2016-03-07 09:10:31.899 screenresolution[1648:7966] starting screenresolution argv=screenresolution get 09:10:31 INFO - 2016-03-07 09:10:31.901 screenresolution[1648:7966] Display 0: 1600x1200x32@60 09:10:31 INFO - 2016-03-07 09:10:31.907 screenresolution[1649:7968] starting screenresolution argv=screenresolution list 09:10:31 INFO - Available Modes on Display 0 09:10:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:10:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:10:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:10:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:10:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:10:32 INFO - Intel Iris: 09:10:32 INFO - Chipset Model: Intel Iris 09:10:32 INFO - Type: GPU 09:10:32 INFO - Bus: Built-In 09:10:32 INFO - VRAM (Dynamic, Max): 1536 MB 09:10:32 INFO - Vendor: Intel (0x8086) 09:10:32 INFO - Device ID: 0x0a2e 09:10:32 INFO - Revision ID: 0x0009 09:10:32 INFO - Displays: 09:10:32 INFO - Display: 09:10:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:10:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:10:32 INFO - Display Serial Number: 1600x1200 60 09:10:32 INFO - Main Display: Yes 09:10:32 INFO - Mirror: Off 09:10:32 INFO - Online: Yes 09:10:32 INFO - Rotation: Supported 09:10:32 INFO - Return code: 0 09:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:10:32 INFO - Python 2.7.3 09:10:32 INFO - Return code: 0 09:10:32 INFO - grabbing minidump binary from tooltool 09:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f9ed30>, '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 0x109dc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f95b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:10:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:10:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:10:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:10:32 INFO - Return code: 0 09:10:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:10:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:10:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:10:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:10:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:10:33 INFO - Return code: 0 09:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--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 09:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0024 --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 09:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0H1CagNt4/Render', 09:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:33 INFO - 'HOME': '/Users/cltbld', 09:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:33 INFO - 'LOGNAME': 'cltbld', 09:10:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:10:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:33 INFO - 'MOZ_NO_REMOTE': '1', 09:10:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:10:33 INFO - 'NO_EM_RESTART': '1', 09:10:33 INFO - 'PAGER': '/bin/cat', 09:10:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:33 INFO - 'PWD': '/builds/slave/test', 09:10:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:33 INFO - 'SHELL': '/bin/bash', 09:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFUD3moqd1/Listeners', 09:10:33 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:33 INFO - 'USER': 'cltbld', 09:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:33 INFO - 'XPC_FLAGS': '0x0', 09:10:33 INFO - 'XPC_SERVICE_NAME': '0', 09:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--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 09:10:33 INFO - mozversion application_buildid: 20160307062903 09:10:33 INFO - mozversion application_changeset: be593a64d7c6a826260514fe758ef32a6ee580f7 09:10:33 INFO - mozversion application_display_name: Nightly 09:10:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:10:33 INFO - mozversion application_name: Firefox 09:10:33 INFO - mozversion application_remotingname: firefox 09:10:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:10:33 INFO - mozversion application_vendor: Mozilla 09:10:33 INFO - mozversion application_version: 48.0a1 09:10:33 INFO - mozversion platform_buildid: 20160307062903 09:10:33 INFO - mozversion platform_changeset: be593a64d7c6a826260514fe758ef32a6ee580f7 09:10:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:10:33 INFO - mozversion platform_version: 48.0a1 09:10:33 INFO - using testdate: 1457370633 09:10:33 INFO - actual date: 1457370633 09:10:33 INFO - starting webserver on 'localhost:49275' 09:10:33 INFO - SUITE-START | Running 2 tests 09:10:33 INFO - TEST-START | dromaeo_css 09:10:33 INFO - operating with platform_type : mac_ 09:10:33 INFO - Initialising browser for dromaeo_css test... 09:10:33 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpqfzDai/profile http://localhost:49275/getInfo.html) 09:10:36 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 09:10:36 INFO - PROCESS | 1667 | colorDepth:24 09:10:36 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 09:10:36 INFO - PROCESS | 1667 | __metrics 09:10:36 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:10:36 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:10:36 INFO - TEST-INFO | 1667: exit 0 09:10:36 INFO - Browser initialized. 09:10:36 INFO - Running cycle 1/1 for dromaeo_css test... 09:10:36 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpqfzDai/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:48 INFO - PROCESS | 1672 | RSS: Main: 246194176 09:10:48 INFO - PROCESS | 1672 | 09:11:39 INFO - PROCESS | 1672 | 1457370699815 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] 09:13:50 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 09:13:51 INFO - PROCESS | 1672 | RSS: Main: 338219008 09:13:51 INFO - PROCESS | 1672 | 09:16:53 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 09:16:54 INFO - PROCESS | 1672 | RSS: Main: 375361536 09:16:54 INFO - PROCESS | 1672 | 09:19:56 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 09:19:57 INFO - PROCESS | 1672 | RSS: Main: 373174272 09:19:57 INFO - PROCESS | 1672 | 09:22:59 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 09:23:00 INFO - PROCESS | 1672 | RSS: Main: 331489280 09:23:00 INFO - PROCESS | 1672 | 09:26:03 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 09:26:03 INFO - PROCESS | 1672 | RSS: Main: 336687104 09:26:03 INFO - PROCESS | 1672 | 09:29:06 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 09:29:06 INFO - PROCESS | 1672 | RSS: Main: 381382656 09:29:06 INFO - PROCESS | 1672 | 09:29:06 INFO - PROCESS | 1672 | __start_tp_report 09:29:06 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 09:29:06 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 09:29:06 INFO - PROCESS | 1672 | |i|pagename|runs| 09:29:06 INFO - PROCESS | 1672 | |0;dojo.html;3407.9659203407964;3479.8782042628513;3499.9475007874885;3522.0842580928984;3548.5386899703035;5511.063119269724;5626.071698169802;5646.237757902682;5649.152627105931;5662.886742265152;5620.57845661575;5636.859078523039;5653.236813030239;5728.198052272674;5743.138529220619;5026.547610715035;5078.238264260353;5081.8221362252325;5090.669106508084;5182.870428239286;5135.743212839362;5139.280500729901;5186.118359878829;5198.844034678966;5264.447233040533;5029.547340739315;5055.064813009587;5128.9230661540105;5144.4083930348115;5154.355705536808;5026.5727413169925;5056.089903817348;5061.063703214917;5073.492650734934;5087.033463641933;4994.800207991676;5003.924941125886;5044.596432285409;5047.596192304643;5053.393592768891;5401.243825864382;5466.617336786387;5536.169574563807;5566.081596536607;5593.244911936918;6178.351273116303;6195.721192546346;6228.377162283736;6236.03341482071;6242.188515492957;5868.41315868414;6284.151639528651;6285.528585356116;6299.527535434815;6307.9684601577155;5569.275994120779;5635.690037048002;5702.144678298247;5741.971290143522;5778.133280007948;6247.9062814056915;6255.562110652301;6274.403931626488;6277.278113016971;6278.183836101278;6021.638701677914;6032.577719559677;6068.362821903725;6097.054956481752;6099.2985806632805;6094.11635312886;6143.788236234952;6172.382761723792;6236.656983865931;6265.342139075423;6178.135061091451;6186.381361863778;6188.721507532172;6195.070739389128;6228.781992630236;6148.938510614926;6169.074638804215;6212.192414986113;6225.252969643671;6230.719617617218;4795.017021510652;4816.8073277069225;4858.611311095104;4867.829625963074;4873.098476781735;4364.825406983685;4388.2759344707765;4398.560143985575;4401.823927042947;4403.163398954189;4761.547652972962;5576.414476479992;5693.943060569424;5715.599908006399;5736.4550367715;6203.31763506014;6226.844328891723;6228.159198508234;6229.844253893689;6239.688015599293;5625.606207565513;5639.238702775155;5654.293213348332;5655.971720141373;5657.43425657431;5215.504527069922;5262.631615786935;5313.282706834605;5346.492083252085;5349.946500535023;6256.124142619946;6270.843228919313;6280.309165991737;6282.277538082996;6292.528060395489;6193.659348735682;6232.619907039876;6258.468030217483;6287.18266625354;6288.27684816252;6188.195534580475;6221.440070393686;6262;6290.087937248982;6292.465140463112;6104.969475152773;6134.631922084689;6150.723217455135;6160.661163636043;6173.290071641639;5637.577181711306;6224.346443623535;6234.127222188807;6263.4362907338555;6265.96867015662;5966.105084237225;5966.940330596639;6013.398660133952;6045.697715114315;6084.361142080195;6014.428629280212;6039.094135879654;6061.909071363845;6069.119977603134;6074.635521868702;5761.654300741969;5830.125481177857;5876.882462350814;5880.14737863016;5907.261592300963;6001.939980600138;6009.338972713085;6072.05883088122;6133.53998450127;6144.78493252734;5774.971125144348;5780.913286300624;5789.594728368974;5802.245708058094;5808.854778630568 09:29:06 INFO - PROCESS | 1672 | |1;ext.html;458.94900677448646;532.7390630678884;537.210300857739;631.9083732858736;634.6826586706646;37939.81030094849;38679.41980870289;38764;38777;38936.41595376068;41621;42108;42148.94627634311;42192.36711449331;42254.57745422545;8282.751517454455;9464.621415143385;9647.276454265959;9659.37214081086;9689.273304502156;9422.34043616947;9558.378705384162;9563.760905977337;9566.139047485725;9578.52107394631;9610;9685.95157024214;9688.273379496566;9689.612415503372;9695.806083878319;9608.183304419133;9645.324827262095;9659.985701501382;9681.225501959862;9686.32195746298;9693.127618514367;9814.263930205192;9841.45871977041;9849.310548261625;9855.704328870146;40485.98785030368;40827.59172408297;40841.183176336606;40861.795691021354;40899.386509202384;3192.3136525647096;3266.183454136466;3372.6795954384293;3706.87025954093;3842.0971071798103;26099.217023489327;27959.266883459142;29426.558601620993;29648.814047438078;29694.40611187764;2587.3531617095728;2721.346876749566;2723.6050772638055;2750.986245068782;2842.77257819376;491098.54450727877;494046;495251;496489;496905;45151.77424112859;45630.859228519555;45790.084198315846;45798;63074.68462657657;45110;45118.420855269906;45179.32231016537;45346.54653453489;45349.54650453453;15856.52430427089;16046.67906641884;16087;16089.275982580812;16101.919490402473;12890.548830791065;12982.15615984958;12983.805242921364;12986.740265194832;13065.432148142283;14781.260936953324;14808.25958702082;14821.40714371413;14911.627209319637;14946.40214391434;6423.42189202974;6532;6606.207255129415;6629.86740265192;6684.899726504106;847.5380917400032;978.4471773447979;1031.7059638003134;1039.298473530364;1064.4518073192312;28437.57343639847;28605.713942860722;28736.379086274035;29222.707772922426;29267.853660731987;1073.4149888310733;1082.410086502858;1099.433791597328;1156.6067537037447;1172.4899668644166;14644.19456929879;14691.632709182357;14897;14953.40186392532;14971.775423368657;458421;533421;540290;540325;540643;58266.54333641608;58612;58999.11501327484;59088;59183.40816591865;1340.2561578323928;1457.1912588513264;1459.4527052355368;1460.0144902190978;1480.193294654416;22295;28430.43139137247;28943;29075.85462072761;29080.7091929078;44637.77681111704;44964.55035449735;45078.32382514331;45097.77451112855;45154.77422612866;367872;368047;368719;368798.3120168764;368816.9354919357;32251.677483225805;33687.326253474304;33867.4919876207;33923;33956.830215848764;44426.77786611046;44804.55195448004;45010.54989450063;45323.773381134204;46333.53666463292;37020;37158.07104822401;37422.81288593649;38081.61918380781;38209.2358152841;35894.461583075754;36084;36602.45096323504;37064.62935370612;37085.81457092805;36181;36356;36495;37134.257314853014;37204.627953721196;30788.076357709306;32103.518447222843;32312.35375292528;32436;32514.51228231531;20884.269050583156;23211.651825222296;24145.51708965846;24773.380665483506;24871.005159793407 09:29:06 INFO - PROCESS | 1672 | |2;jquery.html;355.736754801447;357.51199612528904;357.77638975640235;366.71762742688134;370.3999520776343;19565.413037608876;20323.898380508115;20633.793662063374;21017.789822101775;21055.47361315964;16420.137472769067;19913.800861991374;21012.264570740026;21033.894830525827;21339.6799048014;4697.812087516495;5869.383714709958;5896.793612223573;5904.763809447617;5912.556558258148;4147.274227010276;4289.506706728735;5695.401982791809;6129.969350153243;6402.743890244385;6323.968380158093;6347.206599175103;6349.42855143037;6355.428011478966;6359.077933699611;5385.676859388449;6137.570370074097;6297.4962003039645;6305.558610897239;6307.558470907038;3527.3298073365977;5215.426303106655;5425.593080518976;5435.456454354572;5444.972775136139;12896.290704011275;13493.932530337286;13536.526221582197;24955.376115597075;25142.748572514407;2168.6855405966203;2187.387531491185;2226.7216597925258;2249.606318894187;2581.174024312221;9710.465924374157;9891.30760846741;10134.23993200513;12074.517019319217;15034.548963531111;1527.633367991674;1762.4272111563664;1819.7816262048507;1827.269092363052;1835.1191428114446;101023;107966;108898;114807;115497.42251288774;11189.328640281446;11472.426378681033;11485.368304743319;11485.655430337103;11605.88394116065;13761.17432954026;13848.030637855254;13863.514776982756;13872.653183670489;13900.374483148282;8689.522076285739;8743.169398907094;8807.33944954131;8828.470291782514;8902.554872256362;7508.549487030796;8988.865167022499;8995.415298005608;9021.864672029924;9085.409448385833;3632.9091772705365;4491.528389519119;4496.820127194876;4497.280435130363;4567.931481027787;1750.8074111847686;1804.7290948950665;1830.7345434911863;1869.364416098533;1897.1842107893463;392.1529496288004;400.10975579335746;840.7057529864499;868.6568805321989;1071.7320669832543;11470.713232169262;11795.115366347387;11824.349660768568;11934.22427542207;11947.522099116111;432.5112622736288;445.4476449202965;447.5703324808155;448.7666413465045;457.4784745390258;5950.7917222896995;6067.24159480065;6128.080787881853;6143.815685529441;6176.258848938156;546255;557569;557655;560231;581553;110792.44603776929;113263;114611;118239;118436.63126737416;452.09806436160073;457.90612924350427;459.4348950790546;460.5670669570593;461.4117000823976;10748.301360411548;10944.835827462435;10958.342499450058;11067.889321106686;11094.833577496183;48353;49524.75237623789;49910.75044624899;50057.49942500674;50196.74508137326;59638.70180649069;73843.63078184574;75178;75457;75937;6697.96181591854;7916.485428447132;8002.759917202493;8059.234372734581;8418.494890306602;12173.634790956285;12209.69475763113;12990;13508.797368039292;13540.390682419118;11336.829947550958;11680.240784348991;11700.511672529417;11758.176927614984;11799.233049852075;10434.426106564211;10972;11275.04162146194;11405.714857128638;11624.360660163773;11792.29246245228;11828.822567661664;11927.10546708983;12028.75942481163;12275.140740148105;8119.269265766109;8134.349252059703;8262.545559994258;8265.876011859707;8541.402101852811;8487.702930397654;10828.18788590843;11498.367589782642;11962.743911889474;12045.698857528632 09:29:06 INFO - PROCESS | 1672 | |3;mootools.html;1394.5398018653846;1602.23893650516;1632.0044772688655;1909.7708275006992;2040.7347044884173;7972.68109275629;8514.829703405929;8708.43395179313;8728.301735861132;8733.30133589313;8456.619452124654;8689.17452841979;8695.69565065223;8703.564821758902;8710.390272680916;2160.935171944844;2401;2437.9512409751796;2463.7043554773363;2468.7037555493366;2474.1711526638596;2484.416162201881;2484.9378765530823;2485.962710559343;2487.253823852846;2328.8486248393883;2394.0543485323287;2398.796102331295;2410.7227668818045;2412.746661600533;2338.543983923127;2371.312319427364;2371.774681405264;2395.832291739579;2397.5924092904247;2425.9393515162087;2461.5815311397105;2462.3351695042415;2466.8643224622638;2472.6538284640164;8778.341624378134;8858.911410885874;8865.867011994826;8874.423162494417;8879.378443508956;5362.785488580491;5543.279373681436;5547.833564993057;5555.333359996826;5561.944380556183;3048.7713421493477;3578.3737845877126;3708.592054873962;3736.8318425670636;3761.5110035695457;1038.7195457226508;1054.7679510507676;1056.8373495474584;1057.3021805608262;1065.1159537583865;11693.766124677544;11746.70633234176;11748.236364636357;11751.941240293743;11810.88189118115;4815.277708343707;4838.95161048385;4867.853964381075;4905.901881962341;4931.654784165145;10088.243381746399;10102.040306170902;10110.69667909964;10127.341722787995;10129.848052279222;5507.173923911365;5512.228288039598;5514.91727624086;5518.089515229942;5519.586031047687;4465.888352791206;4521.502634710179;4781.306710527024;4935.284383764334;4938.950610493849;3652.086978255436;3691.4093745000673;3857;3961.623645753649;3989.4414781930554;1309.3649579953715;1315.4869600855675;1318.8944884409225;1321.9405126769318;1333.240053169684;1343.0867010432803;1382.7441923244232;1389.3261768042491;1407.7606806842657;1429.2067902314107;8047.557384343917;8353.164683531599;8363.665453381918;8367.665293388196;8408.915910840813;1127.261643623428;1166.3759888459633;1220.5666988219232;1223.406647775828;1242.4471110355985;6337.809865704036;6351.460125889259;6406.583572067894;6409.743610255631;6411.67941602918;10429.68710938673;10764.838527422095;10883.238173327949;10885.673429797118;10903.400312982703;10411.53148108337;10504.369737815756;10727.731806704895;10743.51654175564;10756.462176891124;8250.257476827115;8438;8466.872996905051;8470.152984701605;8473.576321183917;7833.608319584112;7871.960640196762;7893.644785984529;7921.128675845537;7946.364290856834;9229.984701682675;9549.140577348073;9617.374870633386;9634.421934683942;9662.468564228753;9750.658726944523;9856.359336643382;10018.298719089593;10103.343282686601;10114.797704046025;6380.744770209325;6625.204975402982;6783.559068660521;6884.242733299433;6886.070380498569;7922.366210703245;8175.427720059539;8221.54781487024;8226;8240.381971352053;7265.491415600857;7297.927020729725;7356.043714317105;7445.739399121005;7510.737124200846;7104.289571042855;7208.260860873044;7246.239144889711;7250.093738282715;7275.1997280298065;7572.356349710336;7671.232876712507;7690.0771907369235;7692.076950765944;7692.461527693232;6892.448604111559;6927.82680432973;6980.511364204457;6983.231844497;6984.580925144508;7034.753783617549;7087.00781890546;7107.857842843217;7109.146902371748;7116.608586527791 09:29:06 INFO - PROCESS | 1672 | |4;prototype.html;324.8099861580975;324.8619336781868;329.3133815993653;331.9717823984961;334.3680443960914;6241.531885108618;6307.990721484563;6331.746730130801;6407.391297826711;6421.197350331208;6312.810615681537;6325.905111423321;6342.746290148389;6345.0165224390175;6382.20222472191;4476.529964353745;4526.660500462462;4601.976990115045;4650.813967441299;4714.175019371613;4673.644643053511;4679.227927391977;4679.953200467986;4683.391159149322;4699.647526435531;4632.2125238709505;4634.189016922042;4644.953550464503;4646.674732768707;4653;3706.5181526401666;3833.6358045985585;4391.846285380012;4405.722340521245;4543.0459603483305;3237.660045695215;3891.0855948851995;3976.920461590781;3989.9202015959518;4004.599540046001;4791.7124972501415;5985.760569577212;5999.100134979744;6053.51571874249;6069.211002569682;5425;5425.403205647375;5426.728663566845;5430.755615997289;5431.891362172774;6625.635590042546;6630.63531505767;6652.93347066528;6653.168353955755;6662.067310576524;3753.361928472139;4290.399344091829;4368.49762277339;4441.378207051015;4481.910361792746;7022.087128673291;7057.400120989722;7064.540804847668;7074.045003924456;7075.433965282714;4538.455385353779;4543.318502224627;4547.545245475492;4549.977250113729;4570.177368073779;4616.28447590624;4629.65277604181;4638.1883170445035;4638.675292729544;4642.141203877226;5424.748729277385;5429.538489228381;5430.456954304617;5436.619436639477;5440.047991601454;6392.7123279452535;6594.670266486656;6709.496787740842;6711.228208756055;6728.697208625624;1405.5853523210678;1460.8247010358825;1533.6472611299464;1557.5405255449443;1560.680060587577;993.5439357350664;997.192274257839;1010.6917390196061;1014.7970405918845;1015.3755440404099;6097.664628445389;6200;6207.16203312547;6277.05844123376;6303.401176888188;6822.897656535156;6823.897641535381;6943.132108486439;6960.477964152708;6977.197622273402;6201.069839524017;6311.779087731908;6325.272593651789;6338.01760727088;6343.460805831463;3648.908777280589;3692.6861216796337;3696.5748938871834;3702.0929872181487;3703.4074548072717;6999.12510936133;7342.596157211405;7364.263573642593;7371.447141464304;7404.629768511553;5853.180554722342;7254.528455650366;7275.381592564586;7284.016657751135;7288.8177795554475;7336.633168341562;7355.301246381585;7355.52189107717;7355.7057717690695;7385.741499047507;6994.930050699428;6998.2651821558;7015.123109611299;7027.648617569203;7034.050403195708;6695.545950931397;6797.626130562867;6926.480513961574;6933.618650974245;6956.79129626112;7305.671244794104;7347.485676002629;7355.77932662021;7357.1907090218965;7370.041894553674;4408.845690400821;4442.000549876381;4452.065066335977;4454.265046267459;4459.420275364311;5623.297087864017;6936.757213497705;6965.407940325129;6973.895391569029;6980.232174460907;6479.157709497735;6731.528792984444;6738.090357801634;6746.224184218681;6753;6734.292899245509;6770.424513916372;6783.18601767791;6784.96607516979;6785;6605.702743376656;6608.140941677551;6621.304763000008;6625.138731964814;6638.634875081917;6752.898706519308;6764.391204791593;6778.4916131289365;6784.185897692309;6791.966040169965;5346.411894691503;6406.199225096863;6634.668266586555;6638.634875081723;6654.500912431684 09:29:06 INFO - PROCESS | 1672 | |5;yui.html;700.2647220418562;709.1879797631711;729.7227053719586;762.7597306848343;825.5954582254693;15142.621434464143;15184.848151518481;15353.462628807994;15381.615459613515;15431.69136617267;14357.78463323051;14443.78334324986;14467.276636168202;14476.13143211408;14512.637184070403;749.3892477630741;762.5500954436881;763.0385714000344;910.2444970674358;939.2767568971922;759.5101159751956;764.0754686828916;925.7546750111226;945.9006804285519;948.8149810786899;987.93578417403;988.3180605382299;990.2721499697752;992.290512283717;992.8609994600762;981.5043403081398;984.7045886234137;985.8126955878432;987.7086259553413;989.44096585429;581.7411251992864;731.1555153797319;733.4645708632728;733.7908696021661;736.138717700292;15089.849101509064;15102;15112.546623601309;15173.620659483491;15176.317065732068;12528.81206781899;12539.435725392379;12728.490860365575;12829.294388808612;12891.67770805728;9781.266405019582;10061.597536098621;10246.692599222035;10786.676399708022;10883.401412922287;3572.464130380438;3648.7628304160144;3649.927001459956;3670.2659468106217;3683.0055884911194;74416;75465.49069018589;76923;77550.63268989437;77659.22340776576;8907.465552066897;9324.8601270981;9354.906450935403;9357.204637605744;9983.101520863158;20454.181832726525;20631.071601777956;20634.174633014813;20674.896625516776;20702.68945965812;7630.961845190738;7636.31273185416;7830.295273425305;7912.920870791334;8039.316658084128;3751.268502642013;4186.665066794649;4248.596383343577;4250.489941207075;4262.445882035316;3537.5754909411035;3580.0154957386926;3605.4231322988194;3609.1157666371905;3612.710983121344;645.9967700161469;651.8533330000806;653.0661154549041;660.5343233020709;668.5687731413309;574.2678085441096;575.3125015606394;606.423897297569;608.8143116349468;610.8625559249133;8068.9596552016865;8204.302634276153;8243.777715632572;8395.496270223806;8428.862438089254;556.1935193968761;599.2928344553469;600.6816387314731;624.9312575616678;632.4655665962255;3792.8482860685262;3822.503074600284;3847.249786291646;3894.201688653819;4065.4918135233097;93928.65178370595;95874;95992.52003740077;96424;97189;78675.03312417235;78933.21066789374;80560.59719701365;80677;83296;72191.53222782772;72440.91338629925;73295;74259.62870185722;75383.24616753872;7717.2282771722375;7827.569483678452;7851.842963140591;7884;7893.842123157619;47585.524144759496;48437;51676;51796.70508237324;52058.43824685265;68937.3106268951;73503.63248183725;74006.25993739994;74931.25068749461;75270.6236468836;9725.562349694423;9847.663490699475;10056.597736090474;10086.394816311045;10369.688909332732;10670.30643008202;10851.294665846695;10894.128469722562;10963;12101.939490302491;8193.344532437271;10310.32982856112;10648.988346107108;10858.077063449695;11222.38276894746;10951.233413660968;11077.279976801805;11497;11554.191206615793;11603.709907252387;10962.287451315638;10985.450727463434;11063.50214240345;11103.056240219672;11351.48918298695;9415.105564971316;9652.571291732344;9742.415455072718;9797.412155270707;9878.245577221845;9508.042330664894;9637.518124093627;9675.661351852652;9719.902800972182;9871.605135794487 09:29:06 INFO - PROCESS | 1672 | __end_tp_report 09:29:06 INFO - PROCESS | 1672 | __start_cc_report 09:29:06 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1301 09:29:06 INFO - PROCESS | 1672 | __end_cc_report 09:29:06 INFO - PROCESS | 1672 | __startTimestamp1457371746951__endTimestamp 09:29:06 INFO - PROCESS | 1672 | 09:29:06 INFO - PROCESS | 1672 | ------- Summary: start ------- 09:29:06 INFO - PROCESS | 1672 | Number of tests: 6 09:29:06 INFO - PROCESS | 1672 | 09:29:06 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5682.32 Median:5830.13 stddev:638.79 (11.0%) stddev-sans-first:615.33 09:29:06 INFO - PROCESS | 1672 | Values: 3408.0 3479.9 3499.9 3522.1 3548.5 5511.1 5626.1 5646.2 5649.2 5662.9 5620.6 5636.9 5653.2 5728.2 5743.1 5026.5 5078.2 5081.8 5090.7 5182.9 5135.7 5139.3 5186.1 5198.8 5264.4 5029.5 5055.1 5128.9 5144.4 5154.4 5026.6 5056.1 5061.1 5073.5 5087.0 4994.8 5003.9 5044.6 5047.6 5053.4 5401.2 5466.6 5536.2 5566.1 5593.2 6178.4 6195.7 6228.4 6236.0 6242.2 5868.4 6284.2 6285.5 6299.5 6308.0 5569.3 5635.7 5702.1 5742.0 5778.1 6247.9 6255.6 6274.4 6277.3 6278.2 6021.6 6032.6 6068.4 6097.1 6099.3 6094.1 6143.8 6172.4 6236.7 6265.3 6178.1 6186.4 6188.7 6195.1 6228.8 6148.9 6169.1 6212.2 6225.3 6230.7 4795.0 4816.8 4858.6 4867.8 4873.1 4364.8 4388.3 4398.6 4401.8 4403.2 4761.5 5576.4 5693.9 5715.6 5736.5 6203.3 6226.8 6228.2 6229.8 6239.7 5625.6 5639.2 5654.3 5656.0 5657.4 5215.5 5262.6 5313.3 5346.5 5349.9 6256.1 6270.8 6280.3 6282.3 6292.5 6193.7 6232.6 6258.5 6287.2 6288.3 6188.2 6221.4 6262.0 6290.1 6292.5 6105.0 6134.6 6150.7 6160.7 6173.3 5637.6 6224.3 6234.1 6263.4 6266.0 5966.1 5966.9 6013.4 6045.7 6084.4 6014.4 6039.1 6061.9 6069.1 6074.6 5761.7 5830.1 5876.9 5880.1 5907.3 6001.9 6009.3 6072.1 6133.5 6144.8 5775.0 5780.9 5789.6 5802.2 5808.9 09:29:06 INFO - PROCESS | 1672 | 09:29:06 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:59976.28 Median:38010.71 stddev:124261.86 (326.9%) stddev-sans-first:124530.10 09:29:06 INFO - PROCESS | 1672 | Values: 458.9 532.7 537.2 631.9 634.7 37939.8 38679.4 38764.0 38777.0 38936.4 41621.0 42108.0 42148.9 42192.4 42254.6 8282.8 9464.6 9647.3 9659.4 9689.3 9422.3 9558.4 9563.8 9566.1 9578.5 9610.0 9686.0 9688.3 9689.6 9695.8 9608.2 9645.3 9660.0 9681.2 9686.3 9693.1 9814.3 9841.5 9849.3 9855.7 40486.0 40827.6 40841.2 40861.8 40899.4 3192.3 3266.2 3372.7 3706.9 3842.1 26099.2 27959.3 29426.6 29648.8 29694.4 2587.4 2721.3 2723.6 2751.0 2842.8 491098.5 494046.0 495251.0 496489.0 496905.0 45151.8 45630.9 45790.1 45798.0 63074.7 45110.0 45118.4 45179.3 45346.5 45349.5 15856.5 16046.7 16087.0 16089.3 16101.9 12890.5 12982.2 12983.8 12986.7 13065.4 14781.3 14808.3 14821.4 14911.6 14946.4 6423.4 6532.0 6606.2 6629.9 6684.9 847.5 978.4 1031.7 1039.3 1064.5 28437.6 28605.7 28736.4 29222.7 29267.9 1073.4 1082.4 1099.4 1156.6 1172.5 14644.2 14691.6 14897.0 14953.4 14971.8 458421.0 533421.0 540290.0 540325.0 540643.0 58266.5 58612.0 58999.1 59088.0 59183.4 1340.3 1457.2 1459.5 1460.0 1480.2 22295.0 28430.4 28943.0 29075.9 29080.7 44637.8 44964.6 45078.3 45097.8 45154.8 367872.0 368047.0 368719.0 368798.3 368816.9 32251.7 33687.3 33867.5 33923.0 33956.8 44426.8 44804.6 45010.5 45323.8 46333.5 37020.0 37158.1 37422.8 38081.6 38209.2 35894.5 36084.0 36602.5 37064.6 37085.8 36181.0 36356.0 36495.0 37134.3 37204.6 30788.1 32103.5 32312.4 32436.0 32514.5 20884.3 23211.7 24145.5 24773.4 24871.0 09:29:06 INFO - PROCESS | 1672 | 09:29:06 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:32327.69 Median:357.64 stddev:93493.44 (26141.5%) stddev-sans-first:93724.90 09:29:06 INFO - PROCESS | 1672 | Values: 355.7 357.5 357.8 366.7 370.4 19565.4 20323.9 20633.8 21017.8 21055.5 16420.1 19913.8 21012.3 21033.9 21339.7 4697.8 5869.4 5896.8 5904.8 5912.6 4147.3 4289.5 5695.4 6130.0 6402.7 6324.0 6347.2 6349.4 6355.4 6359.1 5385.7 6137.6 6297.5 6305.6 6307.6 3527.3 5215.4 5425.6 5435.5 5445.0 12896.3 13493.9 13536.5 24955.4 25142.7 2168.7 2187.4 2226.7 2249.6 2581.2 9710.5 9891.3 10134.2 12074.5 15034.5 1527.6 1762.4 1819.8 1827.3 1835.1 101023.0 107966.0 108898.0 114807.0 115497.4 11189.3 11472.4 11485.4 11485.7 11605.9 13761.2 13848.0 13863.5 13872.7 13900.4 8689.5 8743.2 8807.3 8828.5 8902.6 7508.5 8988.9 8995.4 9021.9 9085.4 3632.9 4491.5 4496.8 4497.3 4567.9 1750.8 1804.7 1830.7 1869.4 1897.2 392.2 400.1 840.7 868.7 1071.7 11470.7 11795.1 11824.3 11934.2 11947.5 432.5 445.4 447.6 448.8 457.5 5950.8 6067.2 6128.1 6143.8 6176.3 546255.0 557569.0 557655.0 560231.0 581553.0 110792.4 113263.0 114611.0 118239.0 118436.6 452.1 457.9 459.4 460.6 461.4 10748.3 10944.8 10958.3 11067.9 11094.8 48353.0 49524.8 49910.8 50057.5 50196.7 59638.7 73843.6 75178.0 75457.0 75937.0 6698.0 7916.5 8002.8 8059.2 8418.5 12173.6 12209.7 12990.0 13508.8 13540.4 11336.8 11680.2 11700.5 11758.2 11799.2 10434.4 10972.0 11275.0 11405.7 11624.4 11792.3 11828.8 11927.1 12028.8 12275.1 8119.3 8134.3 8262.5 8265.9 8541.4 8487.7 10828.2 11498.4 11962.7 12045.7 09:29:06 INFO - PROCESS | 1672 | 09:29:06 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:6049.29 Median:4933.47 stddev:3170.79 (64.3%) stddev-sans-first:3160.37 09:29:06 INFO - PROCESS | 1672 | Values: 1394.5 1602.2 1632.0 1909.8 2040.7 7972.7 8514.8 8708.4 8728.3 8733.3 8456.6 8689.2 8695.7 8703.6 8710.4 2160.9 2401.0 2438.0 2463.7 2468.7 2474.2 2484.4 2484.9 2486.0 2487.3 2328.8 2394.1 2398.8 2410.7 2412.7 2338.5 2371.3 2371.8 2395.8 2397.6 2425.9 2461.6 2462.3 2466.9 2472.7 8778.3 8858.9 8865.9 8874.4 8879.4 5362.8 5543.3 5547.8 5555.3 5561.9 3048.8 3578.4 3708.6 3736.8 3761.5 1038.7 1054.8 1056.8 1057.3 1065.1 11693.8 11746.7 11748.2 11751.9 11810.9 4815.3 4839.0 4867.9 4905.9 4931.7 10088.2 10102.0 10110.7 10127.3 10129.8 5507.2 5512.2 5514.9 5518.1 5519.6 4465.9 4521.5 4781.3 4935.3 4939.0 3652.1 3691.4 3857.0 3961.6 3989.4 1309.4 1315.5 1318.9 1321.9 1333.2 1343.1 1382.7 1389.3 1407.8 1429.2 8047.6 8353.2 8363.7 8367.7 8408.9 1127.3 1166.4 1220.6 1223.4 1242.4 6337.8 6351.5 6406.6 6409.7 6411.7 10429.7 10764.8 10883.2 10885.7 10903.4 10411.5 10504.4 10727.7 10743.5 10756.5 8250.3 8438.0 8466.9 8470.2 8473.6 7833.6 7872.0 7893.6 7921.1 7946.4 9230.0 9549.1 9617.4 9634.4 9662.5 9750.7 9856.4 10018.3 10103.3 10114.8 6380.7 6625.2 6783.6 6884.2 6886.1 7922.4 8175.4 8221.5 8226.0 8240.4 7265.5 7297.9 7356.0 7445.7 7510.7 7104.3 7208.3 7246.2 7250.1 7275.2 7572.4 7671.2 7690.1 7692.1 7692.5 6892.4 6927.8 6980.5 6983.2 6984.6 7034.8 7087.0 7107.9 7109.1 7116.6 09:29:06 INFO - PROCESS | 1672 | 09:29:06 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5504.83 Median:6319.04 stddev:1775.83 (28.1%) stddev-sans-first:1737.73 09:29:06 INFO - PROCESS | 1672 | Values: 324.8 324.9 329.3 332.0 334.4 6241.5 6308.0 6331.7 6407.4 6421.2 6312.8 6325.9 6342.7 6345.0 6382.2 4476.5 4526.7 4602.0 4650.8 4714.2 4673.6 4679.2 4680.0 4683.4 4699.6 4632.2 4634.2 4645.0 4646.7 4653.0 3706.5 3833.6 4391.8 4405.7 4543.0 3237.7 3891.1 3976.9 3989.9 4004.6 4791.7 5985.8 5999.1 6053.5 6069.2 5425.0 5425.4 5426.7 5430.8 5431.9 6625.6 6630.6 6652.9 6653.2 6662.1 3753.4 4290.4 4368.5 4441.4 4481.9 7022.1 7057.4 7064.5 7074.0 7075.4 4538.5 4543.3 4547.5 4550.0 4570.2 4616.3 4629.7 4638.2 4638.7 4642.1 5424.7 5429.5 5430.5 5436.6 5440.0 6392.7 6594.7 6709.5 6711.2 6728.7 1405.6 1460.8 1533.6 1557.5 1560.7 993.5 997.2 1010.7 1014.8 1015.4 6097.7 6200.0 6207.2 6277.1 6303.4 6822.9 6823.9 6943.1 6960.5 6977.2 6201.1 6311.8 6325.3 6338.0 6343.5 3648.9 3692.7 3696.6 3702.1 3703.4 6999.1 7342.6 7364.3 7371.4 7404.6 5853.2 7254.5 7275.4 7284.0 7288.8 7336.6 7355.3 7355.5 7355.7 7385.7 6994.9 6998.3 7015.1 7027.6 7034.1 6695.5 6797.6 6926.5 6933.6 6956.8 7305.7 7347.5 7355.8 7357.2 7370.0 4408.8 4442.0 4452.1 4454.3 4459.4 5623.3 6936.8 6965.4 6973.9 6980.2 6479.2 6731.5 6738.1 6746.2 6753.0 6734.3 6770.4 6783.2 6785.0 6785.0 6605.7 6608.1 6621.3 6625.1 6638.6 6752.9 6764.4 6778.5 6784.2 6792.0 5346.4 6406.2 6634.7 6638.6 6654.5 09:29:06 INFO - PROCESS | 1672 | 09:29:06 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:18531.18 Median:664.55 stddev:26395.97 (3972.0%) stddev-sans-first:26436.06 09:29:06 INFO - PROCESS | 1672 | Values: 700.3 709.2 729.7 762.8 825.6 15142.6 15184.8 15353.5 15381.6 15431.7 14357.8 14443.8 14467.3 14476.1 14512.6 749.4 762.6 763.0 910.2 939.3 759.5 764.1 925.8 945.9 948.8 987.9 988.3 990.3 992.3 992.9 981.5 984.7 985.8 987.7 989.4 581.7 731.2 733.5 733.8 736.1 15089.8 15102.0 15112.5 15173.6 15176.3 12528.8 12539.4 12728.5 12829.3 12891.7 9781.3 10061.6 10246.7 10786.7 10883.4 3572.5 3648.8 3649.9 3670.3 3683.0 74416.0 75465.5 76923.0 77550.6 77659.2 8907.5 9324.9 9354.9 9357.2 9983.1 20454.2 20631.1 20634.2 20674.9 20702.7 7631.0 7636.3 7830.3 7912.9 8039.3 3751.3 4186.7 4248.6 4250.5 4262.4 3537.6 3580.0 3605.4 3609.1 3612.7 646.0 651.9 653.1 660.5 668.6 574.3 575.3 606.4 608.8 610.9 8069.0 8204.3 8243.8 8395.5 8428.9 556.2 599.3 600.7 624.9 632.5 3792.8 3822.5 3847.2 3894.2 4065.5 93928.7 95874.0 95992.5 96424.0 97189.0 78675.0 78933.2 80560.6 80677.0 83296.0 72191.5 72440.9 73295.0 74259.6 75383.2 7717.2 7827.6 7851.8 7884.0 7893.8 47585.5 48437.0 51676.0 51796.7 52058.4 68937.3 73503.6 74006.3 74931.3 75270.6 9725.6 9847.7 10056.6 10086.4 10369.7 10670.3 10851.3 10894.1 10963.0 12101.9 8193.3 10310.3 10649.0 10858.1 11222.4 10951.2 11077.3 11497.0 11554.2 11603.7 10962.3 10985.5 11063.5 11103.1 11351.5 9415.1 9652.6 9742.4 9797.4 9878.2 9508.0 9637.5 9675.7 9719.9 9871.6 09:29:06 INFO - PROCESS | 1672 | -------- Summary: end -------- 09:29:06 INFO - PROCESS | 1672 | 09:29:07 INFO - TEST-INFO | 1672: exit 0 09:29:07 INFO - TEST-OK | dromaeo_css | took 1113859ms 09:29:07 INFO - TEST-START | kraken 09:29:07 INFO - operating with platform_type : mac_ 09:29:07 INFO - Initialising browser for kraken test... 09:29:07 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpUqy1ED/profile http://localhost:49275/getInfo.html) 09:29:09 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 09:29:09 INFO - PROCESS | 1679 | colorDepth:24 09:29:09 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 09:29:09 INFO - PROCESS | 1679 | __metrics 09:29:09 INFO - PROCESS | 1679 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:29:09 INFO - PROCESS | 1679 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:29:10 INFO - TEST-INFO | 1679: exit 0 09:29:10 INFO - Browser initialized. 09:29:10 INFO - Running cycle 1/1 for kraken test... 09:29:10 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpUqy1ED/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:29:22 INFO - PROCESS | 1682 | RSS: Main: 246050816 09:29:22 INFO - PROCESS | 1682 | 09:29:25 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 09:29:25 INFO - PROCESS | 1682 | RSS: Main: 293830656 09:29:25 INFO - PROCESS | 1682 | 09:29:28 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 09:29:28 INFO - PROCESS | 1682 | RSS: Main: 302936064 09:29:28 INFO - PROCESS | 1682 | 09:29:32 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 09:29:32 INFO - PROCESS | 1682 | RSS: Main: 285745152 09:29:32 INFO - PROCESS | 1682 | 09:29:34 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 09:29:35 INFO - PROCESS | 1682 | RSS: Main: 287162368 09:29:35 INFO - PROCESS | 1682 | 09:29:37 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:29:37 INFO - PROCESS | 1682 | RSS: Main: 288256000 09:29:37 INFO - PROCESS | 1682 | 09:29:40 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 09:29:41 INFO - PROCESS | 1682 | RSS: Main: 289431552 09:29:41 INFO - PROCESS | 1682 | 09:29:44 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 09:29:44 INFO - PROCESS | 1682 | RSS: Main: 288681984 09:29:44 INFO - PROCESS | 1682 | 09:29:47 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 09:29:47 INFO - PROCESS | 1682 | RSS: Main: 288366592 09:29:47 INFO - PROCESS | 1682 | 09:29:49 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:29:50 INFO - PROCESS | 1682 | RSS: Main: 323428352 09:29:50 INFO - PROCESS | 1682 | 09:29:51 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:29:52 INFO - PROCESS | 1682 | RSS: Main: 323223552 09:29:52 INFO - PROCESS | 1682 | 09:29:54 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:29:55 INFO - PROCESS | 1682 | RSS: Main: 331120640 09:29:55 INFO - PROCESS | 1682 | 09:29:57 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:29:58 INFO - PROCESS | 1682 | RSS: Main: 331628544 09:29:58 INFO - PROCESS | 1682 | 09:30:00 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:30:01 INFO - PROCESS | 1682 | RSS: Main: 333025280 09:30:01 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 09:30:03 INFO - PROCESS | 1682 | RSS: Main: 393314304 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | __start_tp_report 09:30:03 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 09:30:03 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 09:30:03 INFO - PROCESS | 1682 | |i|pagename|runs| 09:30:03 INFO - PROCESS | 1682 | |0;ai-astar;113;108;111;111;111;113;115;113;154;166 09:30:03 INFO - PROCESS | 1682 | |1;audio-beat-detection;156;118;141;153;112;164;157;115;160;117 09:30:03 INFO - PROCESS | 1682 | |2;audio-dft;187;185;186;184;184;185;185;176;186;181 09:30:03 INFO - PROCESS | 1682 | |3;audio-fft;73;73;97;103;75;58;61;71;73;54 09:30:03 INFO - PROCESS | 1682 | |4;audio-oscillator;89;90;131;80;78;91;115;77;77;113 09:30:03 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;89;87;94;83;90;88;90;86;89;86 09:30:03 INFO - PROCESS | 1682 | |6;imaging-darkroom;94;95;95;94;94;94;94;93;95;94 09:30:03 INFO - PROCESS | 1682 | |7;imaging-desaturate;86;85;84;84;84;85;94;101;84;86 09:30:03 INFO - PROCESS | 1682 | |8;json-parse-financial;52;53;53;54;52;53;55;63;55;53 09:30:03 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;66;72;71;75;71;67;66;67;68;72 09:30:03 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;83;83;83;81;81;82;83;79;85;83 09:30:03 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;132;128;128;111;123;136;132;110;130;127 09:30:03 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;139;128;138;137;140;126;138;144;136;139 09:30:03 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;66;67;67;67;67;67;67;66;66;67 09:30:03 INFO - PROCESS | 1682 | __end_tp_report 09:30:03 INFO - PROCESS | 1682 | __start_cc_report 09:30:03 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1264 09:30:03 INFO - PROCESS | 1682 | __end_cc_report 09:30:03 INFO - PROCESS | 1682 | __startTimestamp1457371803453__endTimestamp 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | ------- Summary: start ------- 09:30:03 INFO - PROCESS | 1682 | Number of tests: 14 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:121.50 Median:113.00 stddev:20.57 (18.2%) stddev-sans-first:21.59 09:30:03 INFO - PROCESS | 1682 | Values: 113.0 108.0 111.0 111.0 111.0 113.0 115.0 113.0 154.0 166.0 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:154.50 stddev:21.36 (13.8%) stddev-sans-first:21.79 09:30:03 INFO - PROCESS | 1682 | Values: 156.0 118.0 141.0 153.0 112.0 164.0 157.0 115.0 160.0 117.0 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:183.90 Median:185.00 stddev:3.21 (1.7%) stddev-sans-first:3.21 09:30:03 INFO - PROCESS | 1682 | Values: 187.0 185.0 186.0 184.0 184.0 185.0 185.0 176.0 186.0 181.0 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:73.80 Median:73.00 stddev:15.66 (21.5%) stddev-sans-first:16.61 09:30:03 INFO - PROCESS | 1682 | Values: 73.0 73.0 97.0 103.0 75.0 58.0 61.0 71.0 73.0 54.0 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:79.00 stddev:19.01 (24.1%) stddev-sans-first:20.07 09:30:03 INFO - PROCESS | 1682 | Values: 89.0 90.0 131.0 80.0 78.0 91.0 115.0 77.0 77.0 113.0 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:89.00 stddev:2.97 (3.3%) stddev-sans-first:3.14 09:30:03 INFO - PROCESS | 1682 | Values: 89.0 87.0 94.0 83.0 90.0 88.0 90.0 86.0 89.0 86.0 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:30:03 INFO - PROCESS | 1682 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 94.0 93.0 95.0 94.0 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:87.30 Median:85.00 stddev:5.68 (6.7%) stddev-sans-first:6.00 09:30:03 INFO - PROCESS | 1682 | Values: 86.0 85.0 84.0 84.0 84.0 85.0 94.0 101.0 84.0 86.0 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:53.50 stddev:3.23 (6.0%) stddev-sans-first:3.32 09:30:03 INFO - PROCESS | 1682 | Values: 52.0 53.0 53.0 54.0 52.0 53.0 55.0 63.0 55.0 53.0 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:71.00 stddev:3.10 (4.4%) stddev-sans-first:3.02 09:30:03 INFO - PROCESS | 1682 | Values: 66.0 72.0 71.0 75.0 71.0 67.0 66.0 67.0 68.0 72.0 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.00 stddev:1.64 (2.0%) stddev-sans-first:1.72 09:30:03 INFO - PROCESS | 1682 | Values: 83.0 83.0 83.0 81.0 81.0 82.0 83.0 79.0 85.0 83.0 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:129.00 stddev:8.73 (6.8%) stddev-sans-first:8.96 09:30:03 INFO - PROCESS | 1682 | Values: 132.0 128.0 128.0 111.0 123.0 136.0 132.0 110.0 130.0 127.0 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.50 Median:138.50 stddev:5.46 (3.9%) stddev-sans-first:5.72 09:30:03 INFO - PROCESS | 1682 | Values: 139.0 128.0 138.0 137.0 140.0 126.0 138.0 144.0 136.0 139.0 09:30:03 INFO - PROCESS | 1682 | 09:30:03 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 09:30:03 INFO - PROCESS | 1682 | Values: 66.0 67.0 67.0 67.0 67.0 67.0 67.0 66.0 66.0 67.0 09:30:03 INFO - PROCESS | 1682 | -------- Summary: end -------- 09:30:03 INFO - PROCESS | 1682 | 09:30:04 INFO - TEST-INFO | 1682: exit 0 09:30:04 INFO - TEST-OK | kraken | took 56678ms 09:30:04 INFO - SUITE-END | took 1170s 09:30:04 INFO - Completed test suite (00:19:30) 09:30:04 INFO - javascript benchmark 09:30:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3407.9659203407964, 3479.8782042628513, 3499.9475007874885, 3522.0842580928984, 3548.5386899703035, 5511.063119269724, 5626.071698169802, 5646.237757902682, 5649.152627105931, 5662.886742265152, 5620.57845661575, 5636.859078523039, 5653.236813030239, 5728.198052272674, 5743.138529220619, 5026.547610715035, 5078.238264260353, 5081.8221362252325, 5090.669106508084, 5182.870428239286, 5135.743212839362, 5139.280500729901, 5186.118359878829, 5198.844034678966, 5264.447233040533, 5029.547340739315, 5055.064813009587, 5128.9230661540105, 5144.4083930348115, 5154.355705536808, 5026.5727413169925, 5056.089903817348, 5061.063703214917, 5073.492650734934, 5087.033463641933, 4994.800207991676, 5003.924941125886, 5044.596432285409, 5047.596192304643, 5053.393592768891, 5401.243825864382, 5466.617336786387, 5536.169574563807, 5566.081596536607, 5593.244911936918, 6178.351273116303, 6195.721192546346, 6228.377162283736, 6236.03341482071, 6242.188515492957, 5868.41315868414, 6284.151639528651, 6285.528585356116, 6299.527535434815, 6307.9684601577155, 5569.275994120779, 5635.690037048002, 5702.144678298247, 5741.971290143522, 5778.133280007948, 6247.9062814056915, 6255.562110652301, 6274.403931626488, 6277.278113016971, 6278.183836101278, 6021.638701677914, 6032.577719559677, 6068.362821903725, 6097.054956481752, 6099.2985806632805, 6094.11635312886, 6143.788236234952, 6172.382761723792, 6236.656983865931, 6265.342139075423, 6178.135061091451, 6186.381361863778, 6188.721507532172, 6195.070739389128, 6228.781992630236, 6148.938510614926, 6169.074638804215, 6212.192414986113, 6225.252969643671, 6230.719617617218, 4795.017021510652, 4816.8073277069225, 4858.611311095104, 4867.829625963074, 4873.098476781735, 4364.825406983685, 4388.2759344707765, 4398.560143985575, 4401.823927042947, 4403.163398954189, 4761.547652972962, 5576.414476479992, 5693.943060569424, 5715.599908006399, 5736.4550367715, 6203.31763506014, 6226.844328891723, 6228.159198508234, 6229.844253893689, 6239.688015599293, 5625.606207565513, 5639.238702775155, 5654.293213348332, 5655.971720141373, 5657.43425657431, 5215.504527069922, 5262.631615786935, 5313.282706834605, 5346.492083252085, 5349.946500535023, 6256.124142619946, 6270.843228919313, 6280.309165991737, 6282.277538082996, 6292.528060395489, 6193.659348735682, 6232.619907039876, 6258.468030217483, 6287.18266625354, 6288.27684816252, 6188.195534580475, 6221.440070393686, 6262.0, 6290.087937248982, 6292.465140463112, 6104.969475152773, 6134.631922084689, 6150.723217455135, 6160.661163636043, 6173.290071641639, 5637.577181711306, 6224.346443623535, 6234.127222188807, 6263.4362907338555, 6265.96867015662, 5966.105084237225, 5966.940330596639, 6013.398660133952, 6045.697715114315, 6084.361142080195, 6014.428629280212, 6039.094135879654, 6061.909071363845, 6069.119977603134, 6074.635521868702, 5761.654300741969, 5830.125481177857, 5876.882462350814, 5880.14737863016, 5907.261592300963, 6001.939980600138, 6009.338972713085, 6072.05883088122, 6133.53998450127, 6144.78493252734, 5774.971125144348, 5780.913286300624, 5789.594728368974, 5802.245708058094, 5808.854778630568], "unit": "score", "name": "dojo.html", "value": 5642.040560986685}, {"lowerIsBetter": false, "replicates": [458.94900677448646, 532.7390630678884, 537.210300857739, 631.9083732858736, 634.6826586706646, 37939.81030094849, 38679.41980870289, 38764.0, 38777.0, 38936.41595376068, 41621.0, 42108.0, 42148.94627634311, 42192.36711449331, 42254.57745422545, 8282.751517454455, 9464.621415143385, 9647.276454265959, 9659.37214081086, 9689.273304502156, 9422.34043616947, 9558.378705384162, 9563.760905977337, 9566.139047485725, 9578.52107394631, 9610.0, 9685.95157024214, 9688.273379496566, 9689.612415503372, 9695.806083878319, 9608.183304419133, 9645.324827262095, 9659.985701501382, 9681.225501959862, 9686.32195746298, 9693.127618514367, 9814.263930205192, 9841.45871977041, 9849.310548261625, 9855.704328870146, 40485.98785030368, 40827.59172408297, 40841.183176336606, 40861.795691021354, 40899.386509202384, 3192.3136525647096, 3266.183454136466, 3372.6795954384293, 3706.87025954093, 3842.0971071798103, 26099.217023489327, 27959.266883459142, 29426.558601620993, 29648.814047438078, 29694.40611187764, 2587.3531617095728, 2721.346876749566, 2723.6050772638055, 2750.986245068782, 2842.77257819376, 491098.54450727877, 494046.0, 495251.0, 496489.0, 496905.0, 45151.77424112859, 45630.859228519555, 45790.084198315846, 45798.0, 63074.68462657657, 45110.0, 45118.420855269906, 45179.32231016537, 45346.54653453489, 45349.54650453453, 15856.52430427089, 16046.67906641884, 16087.0, 16089.275982580812, 16101.919490402473, 12890.548830791065, 12982.15615984958, 12983.805242921364, 12986.740265194832, 13065.432148142283, 14781.260936953324, 14808.25958702082, 14821.40714371413, 14911.627209319637, 14946.40214391434, 6423.42189202974, 6532.0, 6606.207255129415, 6629.86740265192, 6684.899726504106, 847.5380917400032, 978.4471773447979, 1031.7059638003134, 1039.298473530364, 1064.4518073192312, 28437.57343639847, 28605.713942860722, 28736.379086274035, 29222.707772922426, 29267.853660731987, 1073.4149888310733, 1082.410086502858, 1099.433791597328, 1156.6067537037447, 1172.4899668644166, 14644.19456929879, 14691.632709182357, 14897.0, 14953.40186392532, 14971.775423368657, 458421.0, 533421.0, 540290.0, 540325.0, 540643.0, 58266.54333641608, 58612.0, 58999.11501327484, 59088.0, 59183.40816591865, 1340.2561578323928, 1457.1912588513264, 1459.4527052355368, 1460.0144902190978, 1480.193294654416, 22295.0, 28430.43139137247, 28943.0, 29075.85462072761, 29080.7091929078, 44637.77681111704, 44964.55035449735, 45078.32382514331, 45097.77451112855, 45154.77422612866, 367872.0, 368047.0, 368719.0, 368798.3120168764, 368816.9354919357, 32251.677483225805, 33687.326253474304, 33867.4919876207, 33923.0, 33956.830215848764, 44426.77786611046, 44804.55195448004, 45010.54989450063, 45323.773381134204, 46333.53666463292, 37020.0, 37158.07104822401, 37422.81288593649, 38081.61918380781, 38209.2358152841, 35894.461583075754, 36084.0, 36602.45096323504, 37064.62935370612, 37085.81457092805, 36181.0, 36356.0, 36495.0, 37134.257314853014, 37204.627953721196, 30788.076357709306, 32103.518447222843, 32312.35375292528, 32436.0, 32514.51228231531, 20884.269050583156, 23211.651825222296, 24145.51708965846, 24773.380665483506, 24871.005159793407], "unit": "score", "name": "ext.html", "value": 18965.50750032203}, {"lowerIsBetter": false, "replicates": [355.736754801447, 357.51199612528904, 357.77638975640235, 366.71762742688134, 370.3999520776343, 19565.413037608876, 20323.898380508115, 20633.793662063374, 21017.789822101775, 21055.47361315964, 16420.137472769067, 19913.800861991374, 21012.264570740026, 21033.894830525827, 21339.6799048014, 4697.812087516495, 5869.383714709958, 5896.793612223573, 5904.763809447617, 5912.556558258148, 4147.274227010276, 4289.506706728735, 5695.401982791809, 6129.969350153243, 6402.743890244385, 6323.968380158093, 6347.206599175103, 6349.42855143037, 6355.428011478966, 6359.077933699611, 5385.676859388449, 6137.570370074097, 6297.4962003039645, 6305.558610897239, 6307.558470907038, 3527.3298073365977, 5215.426303106655, 5425.593080518976, 5435.456454354572, 5444.972775136139, 12896.290704011275, 13493.932530337286, 13536.526221582197, 24955.376115597075, 25142.748572514407, 2168.6855405966203, 2187.387531491185, 2226.7216597925258, 2249.606318894187, 2581.174024312221, 9710.465924374157, 9891.30760846741, 10134.23993200513, 12074.517019319217, 15034.548963531111, 1527.633367991674, 1762.4272111563664, 1819.7816262048507, 1827.269092363052, 1835.1191428114446, 101023.0, 107966.0, 108898.0, 114807.0, 115497.42251288774, 11189.328640281446, 11472.426378681033, 11485.368304743319, 11485.655430337103, 11605.88394116065, 13761.17432954026, 13848.030637855254, 13863.514776982756, 13872.653183670489, 13900.374483148282, 8689.522076285739, 8743.169398907094, 8807.33944954131, 8828.470291782514, 8902.554872256362, 7508.549487030796, 8988.865167022499, 8995.415298005608, 9021.864672029924, 9085.409448385833, 3632.9091772705365, 4491.528389519119, 4496.820127194876, 4497.280435130363, 4567.931481027787, 1750.8074111847686, 1804.7290948950665, 1830.7345434911863, 1869.364416098533, 1897.1842107893463, 392.1529496288004, 400.10975579335746, 840.7057529864499, 868.6568805321989, 1071.7320669832543, 11470.713232169262, 11795.115366347387, 11824.349660768568, 11934.22427542207, 11947.522099116111, 432.5112622736288, 445.4476449202965, 447.5703324808155, 448.7666413465045, 457.4784745390258, 5950.7917222896995, 6067.24159480065, 6128.080787881853, 6143.815685529441, 6176.258848938156, 546255.0, 557569.0, 557655.0, 560231.0, 581553.0, 110792.44603776929, 113263.0, 114611.0, 118239.0, 118436.63126737416, 452.09806436160073, 457.90612924350427, 459.4348950790546, 460.5670669570593, 461.4117000823976, 10748.301360411548, 10944.835827462435, 10958.342499450058, 11067.889321106686, 11094.833577496183, 48353.0, 49524.75237623789, 49910.75044624899, 50057.49942500674, 50196.74508137326, 59638.70180649069, 73843.63078184574, 75178.0, 75457.0, 75937.0, 6697.96181591854, 7916.485428447132, 8002.759917202493, 8059.234372734581, 8418.494890306602, 12173.634790956285, 12209.69475763113, 12990.0, 13508.797368039292, 13540.390682419118, 11336.829947550958, 11680.240784348991, 11700.511672529417, 11758.176927614984, 11799.233049852075, 10434.426106564211, 10972.0, 11275.04162146194, 11405.714857128638, 11624.360660163773, 11792.29246245228, 11828.822567661664, 11927.10546708983, 12028.75942481163, 12275.140740148105, 8119.269265766109, 8134.349252059703, 8262.545559994258, 8265.876011859707, 8541.402101852811, 8487.702930397654, 10828.18788590843, 11498.367589782642, 11962.743911889474, 12045.698857528632], "unit": "score", "name": "jquery.html", "value": 8497.578540897948}, {"lowerIsBetter": false, "replicates": [1394.5398018653846, 1602.23893650516, 1632.0044772688655, 1909.7708275006992, 2040.7347044884173, 7972.68109275629, 8514.829703405929, 8708.43395179313, 8728.301735861132, 8733.30133589313, 8456.619452124654, 8689.17452841979, 8695.69565065223, 8703.564821758902, 8710.390272680916, 2160.935171944844, 2401.0, 2437.9512409751796, 2463.7043554773363, 2468.7037555493366, 2474.1711526638596, 2484.416162201881, 2484.9378765530823, 2485.962710559343, 2487.253823852846, 2328.8486248393883, 2394.0543485323287, 2398.796102331295, 2410.7227668818045, 2412.746661600533, 2338.543983923127, 2371.312319427364, 2371.774681405264, 2395.832291739579, 2397.5924092904247, 2425.9393515162087, 2461.5815311397105, 2462.3351695042415, 2466.8643224622638, 2472.6538284640164, 8778.341624378134, 8858.911410885874, 8865.867011994826, 8874.423162494417, 8879.378443508956, 5362.785488580491, 5543.279373681436, 5547.833564993057, 5555.333359996826, 5561.944380556183, 3048.7713421493477, 3578.3737845877126, 3708.592054873962, 3736.8318425670636, 3761.5110035695457, 1038.7195457226508, 1054.7679510507676, 1056.8373495474584, 1057.3021805608262, 1065.1159537583865, 11693.766124677544, 11746.70633234176, 11748.236364636357, 11751.941240293743, 11810.88189118115, 4815.277708343707, 4838.95161048385, 4867.853964381075, 4905.901881962341, 4931.654784165145, 10088.243381746399, 10102.040306170902, 10110.69667909964, 10127.341722787995, 10129.848052279222, 5507.173923911365, 5512.228288039598, 5514.91727624086, 5518.089515229942, 5519.586031047687, 4465.888352791206, 4521.502634710179, 4781.306710527024, 4935.284383764334, 4938.950610493849, 3652.086978255436, 3691.4093745000673, 3857.0, 3961.623645753649, 3989.4414781930554, 1309.3649579953715, 1315.4869600855675, 1318.8944884409225, 1321.9405126769318, 1333.240053169684, 1343.0867010432803, 1382.7441923244232, 1389.3261768042491, 1407.7606806842657, 1429.2067902314107, 8047.557384343917, 8353.164683531599, 8363.665453381918, 8367.665293388196, 8408.915910840813, 1127.261643623428, 1166.3759888459633, 1220.5666988219232, 1223.406647775828, 1242.4471110355985, 6337.809865704036, 6351.460125889259, 6406.583572067894, 6409.743610255631, 6411.67941602918, 10429.68710938673, 10764.838527422095, 10883.238173327949, 10885.673429797118, 10903.400312982703, 10411.53148108337, 10504.369737815756, 10727.731806704895, 10743.51654175564, 10756.462176891124, 8250.257476827115, 8438.0, 8466.872996905051, 8470.152984701605, 8473.576321183917, 7833.608319584112, 7871.960640196762, 7893.644785984529, 7921.128675845537, 7946.364290856834, 9229.984701682675, 9549.140577348073, 9617.374870633386, 9634.421934683942, 9662.468564228753, 9750.658726944523, 9856.359336643382, 10018.298719089593, 10103.343282686601, 10114.797704046025, 6380.744770209325, 6625.204975402982, 6783.559068660521, 6884.242733299433, 6886.070380498569, 7922.366210703245, 8175.427720059539, 8221.54781487024, 8226.0, 8240.381971352053, 7265.491415600857, 7297.927020729725, 7356.043714317105, 7445.739399121005, 7510.737124200846, 7104.289571042855, 7208.260860873044, 7246.239144889711, 7250.093738282715, 7275.1997280298065, 7572.356349710336, 7671.232876712507, 7690.0771907369235, 7692.076950765944, 7692.461527693232, 6892.448604111559, 6927.82680432973, 6980.511364204457, 6983.231844497, 6984.580925144508, 7034.753783617549, 7087.00781890546, 7107.857842843217, 7109.146902371748, 7116.608586527791], "unit": "score", "name": "mootools.html", "value": 4952.621306847321}, {"lowerIsBetter": false, "replicates": [324.8099861580975, 324.8619336781868, 329.3133815993653, 331.9717823984961, 334.3680443960914, 6241.531885108618, 6307.990721484563, 6331.746730130801, 6407.391297826711, 6421.197350331208, 6312.810615681537, 6325.905111423321, 6342.746290148389, 6345.0165224390175, 6382.20222472191, 4476.529964353745, 4526.660500462462, 4601.976990115045, 4650.813967441299, 4714.175019371613, 4673.644643053511, 4679.227927391977, 4679.953200467986, 4683.391159149322, 4699.647526435531, 4632.2125238709505, 4634.189016922042, 4644.953550464503, 4646.674732768707, 4653.0, 3706.5181526401666, 3833.6358045985585, 4391.846285380012, 4405.722340521245, 4543.0459603483305, 3237.660045695215, 3891.0855948851995, 3976.920461590781, 3989.9202015959518, 4004.599540046001, 4791.7124972501415, 5985.760569577212, 5999.100134979744, 6053.51571874249, 6069.211002569682, 5425.0, 5425.403205647375, 5426.728663566845, 5430.755615997289, 5431.891362172774, 6625.635590042546, 6630.63531505767, 6652.93347066528, 6653.168353955755, 6662.067310576524, 3753.361928472139, 4290.399344091829, 4368.49762277339, 4441.378207051015, 4481.910361792746, 7022.087128673291, 7057.400120989722, 7064.540804847668, 7074.045003924456, 7075.433965282714, 4538.455385353779, 4543.318502224627, 4547.545245475492, 4549.977250113729, 4570.177368073779, 4616.28447590624, 4629.65277604181, 4638.1883170445035, 4638.675292729544, 4642.141203877226, 5424.748729277385, 5429.538489228381, 5430.456954304617, 5436.619436639477, 5440.047991601454, 6392.7123279452535, 6594.670266486656, 6709.496787740842, 6711.228208756055, 6728.697208625624, 1405.5853523210678, 1460.8247010358825, 1533.6472611299464, 1557.5405255449443, 1560.680060587577, 993.5439357350664, 997.192274257839, 1010.6917390196061, 1014.7970405918845, 1015.3755440404099, 6097.664628445389, 6200.0, 6207.16203312547, 6277.05844123376, 6303.401176888188, 6822.897656535156, 6823.897641535381, 6943.132108486439, 6960.477964152708, 6977.197622273402, 6201.069839524017, 6311.779087731908, 6325.272593651789, 6338.01760727088, 6343.460805831463, 3648.908777280589, 3692.6861216796337, 3696.5748938871834, 3702.0929872181487, 3703.4074548072717, 6999.12510936133, 7342.596157211405, 7364.263573642593, 7371.447141464304, 7404.629768511553, 5853.180554722342, 7254.528455650366, 7275.381592564586, 7284.016657751135, 7288.8177795554475, 7336.633168341562, 7355.301246381585, 7355.52189107717, 7355.7057717690695, 7385.741499047507, 6994.930050699428, 6998.2651821558, 7015.123109611299, 7027.648617569203, 7034.050403195708, 6695.545950931397, 6797.626130562867, 6926.480513961574, 6933.618650974245, 6956.79129626112, 7305.671244794104, 7347.485676002629, 7355.77932662021, 7357.1907090218965, 7370.041894553674, 4408.845690400821, 4442.000549876381, 4452.065066335977, 4454.265046267459, 4459.420275364311, 5623.297087864017, 6936.757213497705, 6965.407940325129, 6973.895391569029, 6980.232174460907, 6479.157709497735, 6731.528792984444, 6738.090357801634, 6746.224184218681, 6753.0, 6734.292899245509, 6770.424513916372, 6783.18601767791, 6784.96607516979, 6785.0, 6605.702743376656, 6608.140941677551, 6621.304763000008, 6625.138731964814, 6638.634875081917, 6752.898706519308, 6764.391204791593, 6778.4916131289365, 6784.185897692309, 6791.966040169965, 5346.411894691503, 6406.199225096863, 6634.668266586555, 6638.634875081723, 6654.500912431684], "unit": "score", "name": "prototype.html", "value": 4913.077599524459}, {"lowerIsBetter": false, "replicates": [700.2647220418562, 709.1879797631711, 729.7227053719586, 762.7597306848343, 825.5954582254693, 15142.621434464143, 15184.848151518481, 15353.462628807994, 15381.615459613515, 15431.69136617267, 14357.78463323051, 14443.78334324986, 14467.276636168202, 14476.13143211408, 14512.637184070403, 749.3892477630741, 762.5500954436881, 763.0385714000344, 910.2444970674358, 939.2767568971922, 759.5101159751956, 764.0754686828916, 925.7546750111226, 945.9006804285519, 948.8149810786899, 987.93578417403, 988.3180605382299, 990.2721499697752, 992.290512283717, 992.8609994600762, 981.5043403081398, 984.7045886234137, 985.8126955878432, 987.7086259553413, 989.44096585429, 581.7411251992864, 731.1555153797319, 733.4645708632728, 733.7908696021661, 736.138717700292, 15089.849101509064, 15102.0, 15112.546623601309, 15173.620659483491, 15176.317065732068, 12528.81206781899, 12539.435725392379, 12728.490860365575, 12829.294388808612, 12891.67770805728, 9781.266405019582, 10061.597536098621, 10246.692599222035, 10786.676399708022, 10883.401412922287, 3572.464130380438, 3648.7628304160144, 3649.927001459956, 3670.2659468106217, 3683.0055884911194, 74416.0, 75465.49069018589, 76923.0, 77550.63268989437, 77659.22340776576, 8907.465552066897, 9324.8601270981, 9354.906450935403, 9357.204637605744, 9983.101520863158, 20454.181832726525, 20631.071601777956, 20634.174633014813, 20674.896625516776, 20702.68945965812, 7630.961845190738, 7636.31273185416, 7830.295273425305, 7912.920870791334, 8039.316658084128, 3751.268502642013, 4186.665066794649, 4248.596383343577, 4250.489941207075, 4262.445882035316, 3537.5754909411035, 3580.0154957386926, 3605.4231322988194, 3609.1157666371905, 3612.710983121344, 645.9967700161469, 651.8533330000806, 653.0661154549041, 660.5343233020709, 668.5687731413309, 574.2678085441096, 575.3125015606394, 606.423897297569, 608.8143116349468, 610.8625559249133, 8068.9596552016865, 8204.302634276153, 8243.777715632572, 8395.496270223806, 8428.862438089254, 556.1935193968761, 599.2928344553469, 600.6816387314731, 624.9312575616678, 632.4655665962255, 3792.8482860685262, 3822.503074600284, 3847.249786291646, 3894.201688653819, 4065.4918135233097, 93928.65178370595, 95874.0, 95992.52003740077, 96424.0, 97189.0, 78675.03312417235, 78933.21066789374, 80560.59719701365, 80677.0, 83296.0, 72191.53222782772, 72440.91338629925, 73295.0, 74259.62870185722, 75383.24616753872, 7717.2282771722375, 7827.569483678452, 7851.842963140591, 7884.0, 7893.842123157619, 47585.524144759496, 48437.0, 51676.0, 51796.70508237324, 52058.43824685265, 68937.3106268951, 73503.63248183725, 74006.25993739994, 74931.25068749461, 75270.6236468836, 9725.562349694423, 9847.663490699475, 10056.597736090474, 10086.394816311045, 10369.688909332732, 10670.30643008202, 10851.294665846695, 10894.128469722562, 10963.0, 12101.939490302491, 8193.344532437271, 10310.32982856112, 10648.988346107108, 10858.077063449695, 11222.38276894746, 10951.233413660968, 11077.279976801805, 11497.0, 11554.191206615793, 11603.709907252387, 10962.287451315638, 10985.450727463434, 11063.50214240345, 11103.056240219672, 11351.48918298695, 9415.105564971316, 9652.571291732344, 9742.415455072718, 9797.412155270707, 9878.245577221845, 9508.042330664894, 9637.518124093627, 9675.661351852652, 9719.902800972182, 9871.605135794487], "unit": "score", "name": "yui.html", "value": 6913.740014102083}], "name": "dromaeo_css", "value": 7313.162137048296}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 111.0, 111.0, 111.0, 113.0, 115.0, 113.0, 154.0, 166.0], "unit": "score", "name": "ai-astar", "value": 121.5}, {"lowerIsBetter": true, "replicates": [156.0, 118.0, 141.0, 153.0, 112.0, 164.0, 157.0, 115.0, 160.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 139.3}, {"lowerIsBetter": true, "replicates": [187.0, 185.0, 186.0, 184.0, 184.0, 185.0, 185.0, 176.0, 186.0, 181.0], "unit": "score", "name": "audio-dft", "value": 183.9}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 97.0, 103.0, 75.0, 58.0, 61.0, 71.0, 73.0, 54.0], "unit": "score", "name": "audio-fft", "value": 73.8}, {"lowerIsBetter": true, "replicates": [89.0, 90.0, 131.0, 80.0, 78.0, 91.0, 115.0, 77.0, 77.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 94.1}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 94.0, 83.0, 90.0, 88.0, 90.0, 86.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.2}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 93.0, 95.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.2}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 84.0, 84.0, 84.0, 85.0, 94.0, 101.0, 84.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 87.3}, {"lowerIsBetter": true, "replicates": [52.0, 53.0, 53.0, 54.0, 52.0, 53.0, 55.0, 63.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.3}, {"lowerIsBetter": true, "replicates": [66.0, 72.0, 71.0, 75.0, 71.0, 67.0, 66.0, 67.0, 68.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 81.0, 81.0, 82.0, 83.0, 79.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [132.0, 128.0, 128.0, 111.0, 123.0, 136.0, 132.0, 110.0, 130.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.7}, {"lowerIsBetter": true, "replicates": [139.0, 128.0, 138.0, 137.0, 140.0, 126.0, 138.0, 144.0, 136.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.5}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1417.3000000000002}]} 09:30:04 INFO - Return code: 0 09:30:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:30:04 INFO - # TBPL SUCCESS # 09:30:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:30:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:30:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:30:04 INFO - 2016-03-07 09:30:04.741 screenresolution[1687:10004] starting screenresolution argv=screenresolution get 09:30:04 INFO - 2016-03-07 09:30:04.743 screenresolution[1687:10004] Display 0: 1600x1200x32@60 09:30:04 INFO - 2016-03-07 09:30:04.749 screenresolution[1688:10007] starting screenresolution argv=screenresolution list 09:30:04 INFO - Available Modes on Display 0 09:30:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:30:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:30:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:30:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:30:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:30:04 INFO - Intel Iris: 09:30:04 INFO - Chipset Model: Intel Iris 09:30:04 INFO - Type: GPU 09:30:04 INFO - Bus: Built-In 09:30:04 INFO - VRAM (Dynamic, Max): 1536 MB 09:30:04 INFO - Vendor: Intel (0x8086) 09:30:04 INFO - Device ID: 0x0a2e 09:30:04 INFO - Revision ID: 0x0009 09:30:04 INFO - Displays: 09:30:04 INFO - Display: 09:30:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:30:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:30:04 INFO - Display Serial Number: 1600x1200 60 09:30:04 INFO - Main Display: Yes 09:30:04 INFO - Mirror: Off 09:30:04 INFO - Online: Yes 09:30:04 INFO - Rotation: Supported 09:30:04 INFO - Return code: 0 09:30:04 INFO - Running post-action listener: _resource_record_post_action 09:30:04 INFO - Running post-run listener: _resource_record_post_run 09:30:06 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 34250240; Write bytes: 705676800; Read time: 358; Write time: 2352 09:30:06 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 386525696; Write bytes: 379037696; Read time: 30090; Write time: 840 09:30:06 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 33328640; Write bytes: 302149120; Read time: 344; Write time: 1459 09:30:06 INFO - Running post-run listener: _upload_blobber_files 09:30:06 INFO - Blob upload gear active. 09:30:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:30:06 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 09:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:30:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:30:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:30:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:30:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:07 INFO - (blobuploader) - INFO - Done attempting. 09:30:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:30:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:30:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:08 INFO - (blobuploader) - INFO - Done attempting. 09:30:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:30:08 INFO - Return code: 0 09:30:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:30:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:30:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/065525ba0d9925d8382fe0f3b291da6e586604e3ec94105bfcee29e996e9ac304f323e17500ad0118a06386dfee774cd02de3662dfe17c1449725842cf667ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15923446302a76df7c513609aa771541d78e27016c33b568abfbd15690c90859e3cd747aabfa8ec9055d43055c7272c269abb24d62eff4539344f67b8f10ad4e"} 09:30:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:30:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:30:08 INFO - Contents: 09:30:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/065525ba0d9925d8382fe0f3b291da6e586604e3ec94105bfcee29e996e9ac304f323e17500ad0118a06386dfee774cd02de3662dfe17c1449725842cf667ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15923446302a76df7c513609aa771541d78e27016c33b568abfbd15690c90859e3cd747aabfa8ec9055d43055c7272c269abb24d62eff4539344f67b8f10ad4e"} 09:30:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:30:08 INFO - Copying logs to upload dir... 09:30:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:30:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.675925 ========= master_lag: 0.92 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-03-07 09:30:09.471748) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 09:30:09.475247) ========= 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.P0H1CagNt4/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.fFUD3moqd1/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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/Firefox/sha512/065525ba0d9925d8382fe0f3b291da6e586604e3ec94105bfcee29e996e9ac304f323e17500ad0118a06386dfee774cd02de3662dfe17c1449725842cf667ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15923446302a76df7c513609aa771541d78e27016c33b568abfbd15690c90859e3cd747aabfa8ec9055d43055c7272c269abb24d62eff4539344f67b8f10ad4e"} build_url:https://queue.taskcluster.net/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/EER0UwsQRKWGeokTv4ZSww/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/065525ba0d9925d8382fe0f3b291da6e586604e3ec94105bfcee29e996e9ac304f323e17500ad0118a06386dfee774cd02de3662dfe17c1449725842cf667ad1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15923446302a76df7c513609aa771541d78e27016c33b568abfbd15690c90859e3cd747aabfa8ec9055d43055c7272c269abb24d62eff4539344f67b8f10ad4e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 09:30:09.508034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:30:09.508345) ========= 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.P0H1CagNt4/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.fFUD3moqd1/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.005051 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:30:09.556576) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 09:30:09.556887) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 09:30:09.557253) ========= ========= Total master_lag: 2.20 =========