builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0166 starttime: 1457777227.89 results: success (0) buildid: 20160312004006 builduid: b7bdf1ffc618473ba4b36f6297c9adea revision: edcc2ad52ece9427517f1bc7d1d4e9497ed479f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:07.889976) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:07.890371) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:07.890655) ========= 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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.005711 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:07.969433) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:07.969762) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:08.040217) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:08.040577) ========= 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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.005269 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:08.126920) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:08.127230) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:08.127579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:08.127856) ========= 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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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-12 02:07:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.51M=0.001s 2016-03-12 02:07:08 (8.51 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.553532 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:08.727951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:08.728240) ========= 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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.020237 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:08.794264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:08.794565) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev edcc2ad52ece9427517f1bc7d1d4e9497ed479f6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev edcc2ad52ece9427517f1bc7d1d4e9497ed479f6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2hBVv1qKhv/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.M6QeCNKIKk/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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-12 02:07:08,880 truncating revision to first 12 chars 2016-03-12 02:07:08,880 Setting DEBUG logging. 2016-03-12 02:07:08,880 attempt 1/10 2016-03-12 02:07:08,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/edcc2ad52ece?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-12 02:07:09,491 unpacking tar archive at: mozilla-aurora-edcc2ad52ece/testing/mozharness/ program finished with exit code 0 elapsedTime=0.855255 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:09.778462) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:09.778765) ========= echo edcc2ad52ece9427517f1bc7d1d4e9497ed479f6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'edcc2ad52ece9427517f1bc7d1d4e9497ed479f6'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2hBVv1qKhv/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.M6QeCNKIKk/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 edcc2ad52ece9427517f1bc7d1d4e9497ed479f6 program finished with exit code 0 elapsedTime=0.005553 script_repo_revision: 'edcc2ad52ece9427517f1bc7d1d4e9497ed479f6' ========= master_lag: 0.14 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:09.924292) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:09.924602) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 02:07:10.488046) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-12 02:07:10.488518) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2hBVv1qKhv/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.M6QeCNKIKk/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:07:10 INFO - MultiFileLogger online at 20160312 02:07:10 in /builds/slave/test 02:07:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:07:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:07:10 INFO - {'append_to_log': False, 02:07:10 INFO - 'base_work_dir': '/builds/slave/test', 02:07:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:07:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:07:10 INFO - 'branch': 'Mozilla-Aurora', 02:07:10 INFO - 'buildbot_json_path': 'buildprops.json', 02:07:10 INFO - 'config_files': ('talos/mac_config.py',), 02:07:10 INFO - 'default_actions': ('clobber', 02:07:10 INFO - 'read-buildbot-config', 02:07:10 INFO - 'download-and-extract', 02:07:10 INFO - 'populate-webroot', 02:07:10 INFO - 'create-virtualenv', 02:07:10 INFO - 'install', 02:07:10 INFO - 'run-tests'), 02:07:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:07:10 INFO - 'download_minidump_stackwalk': True, 02:07:10 INFO - 'download_symbols': 'ondemand', 02:07:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:07:10 INFO - 'tooltool.py': '/tools/tooltool.py', 02:07:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:07:10 INFO - '/tools/misc-python/virtualenv.py')}, 02:07:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:07:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:07:10 INFO - 'installer_path': 'installer.exe', 02:07:10 INFO - 'log_level': 'info', 02:07:10 INFO - 'log_name': 'talos', 02:07:10 INFO - 'log_to_console': True, 02:07:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:07:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:07:10 INFO - 'opt_config_files': (), 02:07:10 INFO - 'pip_index': False, 02:07:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:07:10 INFO - 'cmd': ('bash', 02:07:10 INFO - '-c', 02:07:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:07:10 INFO - 'enabled': True, 02:07:10 INFO - 'halt_on_failure': False, 02:07:10 INFO - 'name': 'check_screen_resolution'},), 02:07:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:07:10 INFO - 'cmd': ('bash', 02:07:10 INFO - '-c', 02:07:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:07:10 INFO - 'enabled': True, 02:07:10 INFO - 'halt_on_failure': False, 02:07:10 INFO - 'name': 'check_screen_resolution'},), 02:07:10 INFO - 'run_cmd_checks_enabled': True, 02:07:10 INFO - 'sps_profile': False, 02:07:10 INFO - 'sps_profile_interval': 0, 02:07:10 INFO - 'suite': 'dromaeojs', 02:07:10 INFO - 'system_bits': '32', 02:07:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:07:10 INFO - 'title': 't-yosemite-r7-0166', 02:07:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:07:10 INFO - 'use_talos_json': True, 02:07:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:07:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:07:10 INFO - 'work_dir': 'build'} 02:07:10 INFO - ##### 02:07:10 INFO - ##### Running clobber step. 02:07:10 INFO - ##### 02:07:10 INFO - Running pre-action listener: _resource_record_pre_action 02:07:10 INFO - Running main action method: clobber 02:07:10 INFO - rmtree: /builds/slave/test/build 02:07:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:07:12 INFO - Running post-action listener: _resource_record_post_action 02:07:12 INFO - ##### 02:07:12 INFO - ##### Running read-buildbot-config step. 02:07:12 INFO - ##### 02:07:12 INFO - Running pre-action listener: _resource_record_pre_action 02:07:12 INFO - Running main action method: read_buildbot_config 02:07:12 INFO - Using buildbot properties: 02:07:12 INFO - { 02:07:12 INFO - "project": "", 02:07:12 INFO - "product": "firefox", 02:07:12 INFO - "script_repo_revision": "production", 02:07:12 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:07:12 INFO - "repository": "", 02:07:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:07:12 INFO - "buildid": "20160312004006", 02:07:12 INFO - "stage_platform": "macosx64", 02:07:12 INFO - "basedir": "/builds/slave/test", 02:07:12 INFO - "nightly_build": "True", 02:07:12 INFO - "buildnumber": 121, 02:07:12 INFO - "slavename": "t-yosemite-r7-0166", 02:07:12 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:07:12 INFO - "platform": "yosemite_r7", 02:07:12 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:07:12 INFO - "branch": "mozilla-aurora", 02:07:12 INFO - "repo_path": "releases/mozilla-aurora", 02:07:12 INFO - "revision": "edcc2ad52ece9427517f1bc7d1d4e9497ed479f6", 02:07:12 INFO - "pgo_build": "False", 02:07:12 INFO - "builduid": "b7bdf1ffc618473ba4b36f6297c9adea", 02:07:12 INFO - "slavebuilddir": "test" 02:07:12 INFO - } 02:07:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:07:12 INFO - Running post-action listener: _resource_record_post_action 02:07:12 INFO - ##### 02:07:12 INFO - ##### Running download-and-extract step. 02:07:12 INFO - ##### 02:07:12 INFO - Running pre-action listener: _resource_record_pre_action 02:07:12 INFO - Running main action method: download_and_extract 02:07:12 INFO - mkdir: /builds/slave/test/build/tests 02:07: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')]} 02:07:12 INFO - https://queue.taskcluster.net/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:07:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:07:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:07:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:07:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 02:07:19 INFO - Downloaded 1277 bytes. 02:07:19 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:07:19 INFO - Using the following test package requirements: 02:07:19 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:07:19 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:19 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:07:19 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:19 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:07:19 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:19 INFO - u'jsshell-mac.zip'], 02:07:19 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:19 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:07:19 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:07:19 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:19 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:07:19 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:19 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:07:19 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:19 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:07:19 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:07:19 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:19 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:07:19 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:19 INFO - https://queue.taskcluster.net/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:07:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:07:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:07:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:07:23 INFO - Downloaded 17865048 bytes. 02:07:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:07:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:07:26 INFO - Return code: 0 02:07:26 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:07: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')]} 02:07:26 INFO - https://queue.taskcluster.net/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:07:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:07:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:07:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:07:27 INFO - Downloaded 17865048 bytes. 02:07:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:07:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:07:30 INFO - Return code: 0 02:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:30 INFO - https://queue.taskcluster.net/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:07:33 INFO - Downloaded 10845161 bytes. 02:07:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:07:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:07:34 INFO - Return code: 0 02:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:34 INFO - https://queue.taskcluster.net/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:07:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:07:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:07:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 02:07:37 INFO - Downloaded 114997425 bytes. 02:07:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:07:37 INFO - mkdir: /builds/slave/test/properties 02:07:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:07:37 INFO - Writing to file /builds/slave/test/properties/build_url 02:07:37 INFO - Contents: 02:07:37 INFO - build_url:https://queue.taskcluster.net/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:07:38 INFO - Running post-action listener: _resource_record_post_action 02:07:38 INFO - Running post-action listener: set_extra_try_arguments 02:07:38 INFO - ##### 02:07:38 INFO - ##### Running populate-webroot step. 02:07:38 INFO - ##### 02:07:38 INFO - Running pre-action listener: _resource_record_pre_action 02:07:38 INFO - Running main action method: populate_webroot 02:07:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:07:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:07:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:07:38 INFO - '--tppagecycles', 02:07:38 INFO - '7'], 02:07:38 INFO - 'tests': ['tsvgm']}}, 02:07:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:07:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:07:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:07:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:07:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:07:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:07:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:38 INFO - 'talos_options': ['--e10s'], 02:07:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:38 INFO - 'tests': ['damp', 'tps']}, 02:07:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:38 INFO - 'talos_options': ['--e10s'], 02:07:38 INFO - 'tests': ['damp', 'tps']}, 02:07:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:07:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:07:38 INFO - 'other': {'tests': ['a11yr', 02:07:38 INFO - 'ts_paint', 02:07:38 INFO - 'tpaint', 02:07:38 INFO - 'sessionrestore', 02:07:38 INFO - 'sessionrestore_no_auto_restore', 02:07:38 INFO - 'tabpaint']}, 02:07:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:07:38 INFO - 'tests': ['a11yr', 02:07:38 INFO - 'ts_paint', 02:07:38 INFO - 'tpaint', 02:07:38 INFO - 'sessionrestore', 02:07:38 INFO - 'sessionrestore_no_auto_restore', 02:07:38 INFO - 'tabpaint']}, 02:07:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:07:38 INFO - 'tests': ['a11yr', 02:07:38 INFO - 'ts_paint', 02:07:38 INFO - 'tpaint', 02:07:38 INFO - 'sessionrestore', 02:07:38 INFO - 'sessionrestore_no_auto_restore', 02:07:38 INFO - 'tabpaint']}, 02:07:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:07:38 INFO - 'tests': ['a11yr', 02:07:38 INFO - 'ts_paint', 02:07:38 INFO - 'tpaint', 02:07:38 INFO - 'sessionrestore', 02:07:38 INFO - 'sessionrestore_no_auto_restore', 02:07:38 INFO - 'tabpaint']}, 02:07:38 INFO - 'other_l64': {'tests': ['a11yr', 02:07:38 INFO - 'ts_paint', 02:07:38 INFO - 'tpaint', 02:07:38 INFO - 'sessionrestore', 02:07:38 INFO - 'sessionrestore_no_auto_restore', 02:07:38 INFO - 'tabpaint']}, 02:07:38 INFO - 'other_nol64': {'tests': ['a11yr', 02:07:38 INFO - 'ts_paint', 02:07:38 INFO - 'tpaint', 02:07:38 INFO - 'sessionrestore', 02:07:38 INFO - 'sessionrestore_no_auto_restore', 02:07:38 INFO - 'tabpaint']}, 02:07:38 INFO - 'svgr': {'tests': ['tsvgx', 02:07:38 INFO - 'tsvgr_opacity', 02:07:38 INFO - 'tart', 02:07:38 INFO - 'tscrollx', 02:07:38 INFO - 'cart']}, 02:07:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:07:38 INFO - 'tests': ['tsvgx', 02:07:38 INFO - 'tsvgr_opacity', 02:07:38 INFO - 'tart', 02:07:38 INFO - 'tscrollx', 02:07:38 INFO - 'cart']}, 02:07:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:38 INFO - 'tests': ['tp5o']}, 02:07:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:38 INFO - 'talos_options': ['--e10s'], 02:07:38 INFO - 'tests': ['tp5o']}, 02:07:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:38 INFO - 'talos_options': ['--xperf_path', 02:07:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:38 INFO - 'tests': ['tp5n']}, 02:07:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:38 INFO - 'talos_options': ['--e10s', 02:07:38 INFO - '--xperf_path', 02:07:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:38 INFO - 'tests': ['tp5n']}}, 02:07:38 INFO - 'talos.zip': {'path': '', 02:07:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:07:38 INFO - Running post-action listener: _resource_record_post_action 02:07:38 INFO - ##### 02:07:38 INFO - ##### Running create-virtualenv step. 02:07:38 INFO - ##### 02:07:38 INFO - Running pre-action listener: _resource_record_pre_action 02:07:38 INFO - Running main action method: create_virtualenv 02:07:38 INFO - Creating virtualenv /builds/slave/test/build/venv 02:07:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:07:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:07:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:07:38 INFO - Using real prefix '/tools/python27' 02:07:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:07:38 INFO - Installing distribute.............................................................................................................................................................................................done. 02:07:41 INFO - Installing pip.................done. 02:07:41 INFO - Return code: 0 02:07:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:41 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 0x107531a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d967e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x107239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073ccb20>, '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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:07:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:07:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hBVv1qKhv/Render', 02:07:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:41 INFO - 'HOME': '/Users/cltbld', 02:07:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:41 INFO - 'LOGNAME': 'cltbld', 02:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:41 INFO - 'MOZ_NO_REMOTE': '1', 02:07:41 INFO - 'NO_EM_RESTART': '1', 02:07:41 INFO - 'PAGER': '/bin/cat', 02:07:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:41 INFO - 'PWD': '/builds/slave/test', 02:07:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:41 INFO - 'SHELL': '/bin/bash', 02:07:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M6QeCNKIKk/Listeners', 02:07:41 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 02:07:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:41 INFO - 'USER': 'cltbld', 02:07:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:41 INFO - 'XPC_FLAGS': '0x0', 02:07:41 INFO - 'XPC_SERVICE_NAME': '0', 02:07:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:07:41 INFO - Cleaning up... 02:07:41 INFO - Return code: 0 02:07:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:41 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 0x107531a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d967e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x107239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073ccb20>, '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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:07:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:07:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hBVv1qKhv/Render', 02:07:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:41 INFO - 'HOME': '/Users/cltbld', 02:07:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:41 INFO - 'LOGNAME': 'cltbld', 02:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:41 INFO - 'MOZ_NO_REMOTE': '1', 02:07:41 INFO - 'NO_EM_RESTART': '1', 02:07:41 INFO - 'PAGER': '/bin/cat', 02:07:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:41 INFO - 'PWD': '/builds/slave/test', 02:07:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:41 INFO - 'SHELL': '/bin/bash', 02:07:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M6QeCNKIKk/Listeners', 02:07:41 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 02:07:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:41 INFO - 'USER': 'cltbld', 02:07:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:41 INFO - 'XPC_FLAGS': '0x0', 02:07:41 INFO - 'XPC_SERVICE_NAME': '0', 02:07:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:42 INFO - Downloading/unpacking psutil>=0.7.1 02:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:07:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:45 INFO - Installing collected packages: psutil 02:07:45 INFO - Running setup.py install for psutil 02:07:45 INFO - building 'psutil._psutil_osx' extension 02:07:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:07:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:07:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:07:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:07:46 INFO - building 'psutil._psutil_posix' extension 02:07:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:07:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:07:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:07:46 INFO - ^ 02:07:46 INFO - 1 warning generated. 02:07:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:07:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:46 INFO - Successfully installed psutil 02:07:46 INFO - Cleaning up... 02:07:46 INFO - Return code: 0 02:07:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:46 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 0x107531a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d967e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x107239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073ccb20>, '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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:07:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hBVv1qKhv/Render', 02:07:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:46 INFO - 'HOME': '/Users/cltbld', 02:07:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:46 INFO - 'LOGNAME': 'cltbld', 02:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:46 INFO - 'MOZ_NO_REMOTE': '1', 02:07:46 INFO - 'NO_EM_RESTART': '1', 02:07:46 INFO - 'PAGER': '/bin/cat', 02:07:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:46 INFO - 'PWD': '/builds/slave/test', 02:07:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:46 INFO - 'SHELL': '/bin/bash', 02:07:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M6QeCNKIKk/Listeners', 02:07:46 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 02:07:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:46 INFO - 'USER': 'cltbld', 02:07:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:46 INFO - 'XPC_FLAGS': '0x0', 02:07:46 INFO - 'XPC_SERVICE_NAME': '0', 02:07:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:07:49 INFO - Installing collected packages: mozsystemmonitor 02:07:49 INFO - Running setup.py install for mozsystemmonitor 02:07:49 INFO - Successfully installed mozsystemmonitor 02:07:49 INFO - Cleaning up... 02:07:49 INFO - Return code: 0 02:07:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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', '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 0x107531a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d967e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x107239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073ccb20>, '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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:07: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:07: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 blobuploader==1.2.4 02:07:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hBVv1qKhv/Render', 02:07:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:49 INFO - 'HOME': '/Users/cltbld', 02:07:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:49 INFO - 'LOGNAME': 'cltbld', 02:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:49 INFO - 'MOZ_NO_REMOTE': '1', 02:07:49 INFO - 'NO_EM_RESTART': '1', 02:07:49 INFO - 'PAGER': '/bin/cat', 02:07:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:49 INFO - 'PWD': '/builds/slave/test', 02:07:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:49 INFO - 'SHELL': '/bin/bash', 02:07:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M6QeCNKIKk/Listeners', 02:07:49 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 02:07:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:49 INFO - 'USER': 'cltbld', 02:07:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:49 INFO - 'XPC_FLAGS': '0x0', 02:07:49 INFO - 'XPC_SERVICE_NAME': '0', 02:07:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:49 INFO - Downloading/unpacking blobuploader==1.2.4 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:51 INFO - Downloading blobuploader-1.2.4.tar.gz 02:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:07:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:07:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:52 INFO - Downloading docopt-0.6.1.tar.gz 02:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:07:53 INFO - Installing collected packages: blobuploader, requests, docopt 02:07:53 INFO - Running setup.py install for blobuploader 02:07:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:07:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:07:53 INFO - Running setup.py install for requests 02:07:53 INFO - Running setup.py install for docopt 02:07:53 INFO - Successfully installed blobuploader requests docopt 02:07:53 INFO - Cleaning up... 02:07:53 INFO - Return code: 0 02:07:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:53 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 0x107531a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d967e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x107239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073ccb20>, '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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:07:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:07:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hBVv1qKhv/Render', 02:07:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:53 INFO - 'HOME': '/Users/cltbld', 02:07:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:53 INFO - 'LOGNAME': 'cltbld', 02:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:53 INFO - 'MOZ_NO_REMOTE': '1', 02:07:53 INFO - 'NO_EM_RESTART': '1', 02:07:53 INFO - 'PAGER': '/bin/cat', 02:07:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:53 INFO - 'PWD': '/builds/slave/test', 02:07:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:53 INFO - 'SHELL': '/bin/bash', 02:07:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M6QeCNKIKk/Listeners', 02:07:53 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 02:07:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:53 INFO - 'USER': 'cltbld', 02:07:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:53 INFO - 'XPC_FLAGS': '0x0', 02:07:53 INFO - 'XPC_SERVICE_NAME': '0', 02:07:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-9TPa8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-3izTKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-7f_SwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-bBYHgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-fepeFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-LoRaFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-svjipG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-LWlRM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-5R1PFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-OO82os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-zi5bPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Gggorc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-bbx46N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-VGjjdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-aPtLkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-rAs0_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-mX_zWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:07:55 INFO - Running setup.py install for manifestparser 02:07:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:07:56 INFO - Running setup.py install for mozcrash 02:07:56 INFO - Running setup.py install for mozdebug 02:07:56 INFO - Running setup.py install for mozdevice 02:07:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:07:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:07:56 INFO - Running setup.py install for mozfile 02:07:56 INFO - Running setup.py install for mozhttpd 02:07:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:07:56 INFO - Running setup.py install for mozinfo 02:07:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Running setup.py install for mozInstall 02:07:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Running setup.py install for mozleak 02:07:57 INFO - Running setup.py install for mozlog 02:07:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Running setup.py install for moznetwork 02:07:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Running setup.py install for mozprocess 02:07:57 INFO - Running setup.py install for mozprofile 02:07:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Running setup.py install for mozrunner 02:07:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:07:58 INFO - Running setup.py install for mozscreenshot 02:07:58 INFO - Running setup.py install for moztest 02:07:58 INFO - Running setup.py install for mozversion 02:07:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:07:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:07:58 INFO - Cleaning up... 02:07:58 INFO - Return code: 0 02:07:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:58 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 0x107531a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d967e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x107239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073ccb20>, '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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:07:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hBVv1qKhv/Render', 02:07:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:58 INFO - 'HOME': '/Users/cltbld', 02:07:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:58 INFO - 'LOGNAME': 'cltbld', 02:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:58 INFO - 'MOZ_NO_REMOTE': '1', 02:07:58 INFO - 'NO_EM_RESTART': '1', 02:07:58 INFO - 'PAGER': '/bin/cat', 02:07:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:58 INFO - 'PWD': '/builds/slave/test', 02:07:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:58 INFO - 'SHELL': '/bin/bash', 02:07:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M6QeCNKIKk/Listeners', 02:07:58 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 02:07:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:58 INFO - 'USER': 'cltbld', 02:07:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:58 INFO - 'XPC_FLAGS': '0x0', 02:07:58 INFO - 'XPC_SERVICE_NAME': '0', 02:07:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:58 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-ze0VKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:58 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-_vT3Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:59 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)) 02:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Rbw9d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-BIWmGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-dff7fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-7uG2oI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-xFXLh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-kIjvW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-KgUxFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Z3Mj87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-xSAJ7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-1plfjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:08:00 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-1zvNyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:08:00 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-ig36qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:00 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-LpQQ4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:08:00 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Gtn87_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:08:00 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-c4ftLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:08:00 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)) 02:08:00 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)) 02:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:08:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:02 INFO - Downloading blessings-1.6.tar.gz 02:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:08:03 INFO - Installing collected packages: blessings 02:08:03 INFO - Running setup.py install for blessings 02:08:03 INFO - Successfully installed blessings 02:08:03 INFO - Cleaning up... 02:08:03 INFO - Return code: 0 02:08:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:08:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:03 INFO - Reading from file tmpfile_stdout 02:08:03 INFO - Current package versions: 02:08:03 INFO - blessings == 1.6 02:08:03 INFO - blobuploader == 1.2.4 02:08:03 INFO - docopt == 0.6.1 02:08:03 INFO - manifestparser == 1.1 02:08:03 INFO - mozInstall == 1.12 02:08:03 INFO - mozcrash == 0.17 02:08:03 INFO - mozdebug == 0.1 02:08:03 INFO - mozdevice == 0.48 02:08:03 INFO - mozfile == 1.2 02:08:03 INFO - mozhttpd == 0.7 02:08:03 INFO - mozinfo == 0.9 02:08:03 INFO - mozleak == 0.1 02:08:03 INFO - mozlog == 3.1 02:08:03 INFO - moznetwork == 0.27 02:08:03 INFO - mozprocess == 0.22 02:08:03 INFO - mozprofile == 0.28 02:08:03 INFO - mozrunner == 6.11 02:08:03 INFO - mozscreenshot == 0.1 02:08:03 INFO - mozsystemmonitor == 0.0 02:08:03 INFO - moztest == 0.7 02:08:03 INFO - mozversion == 1.4 02:08:03 INFO - psutil == 3.1.1 02:08:03 INFO - requests == 1.2.3 02:08:03 INFO - wsgiref == 0.1.2 02:08:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:03 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 0x107531a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d967e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x107239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073ccb20>, '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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hBVv1qKhv/Render', 02:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:03 INFO - 'HOME': '/Users/cltbld', 02:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:03 INFO - 'LOGNAME': 'cltbld', 02:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:03 INFO - 'MOZ_NO_REMOTE': '1', 02:08:03 INFO - 'NO_EM_RESTART': '1', 02:08:03 INFO - 'PAGER': '/bin/cat', 02:08:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:03 INFO - 'PWD': '/builds/slave/test', 02:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:03 INFO - 'SHELL': '/bin/bash', 02:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M6QeCNKIKk/Listeners', 02:08:03 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 02:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:03 INFO - 'USER': 'cltbld', 02:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:03 INFO - 'XPC_FLAGS': '0x0', 02:08:03 INFO - 'XPC_SERVICE_NAME': '0', 02:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:08:03 INFO - Cleaning up... 02:08:03 INFO - Return code: 0 02:08:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:03 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 0x107531a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d967e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x107239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073ccb20>, '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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hBVv1qKhv/Render', 02:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:03 INFO - 'HOME': '/Users/cltbld', 02:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:03 INFO - 'LOGNAME': 'cltbld', 02:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:03 INFO - 'MOZ_NO_REMOTE': '1', 02:08:03 INFO - 'NO_EM_RESTART': '1', 02:08:03 INFO - 'PAGER': '/bin/cat', 02:08:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:03 INFO - 'PWD': '/builds/slave/test', 02:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:03 INFO - 'SHELL': '/bin/bash', 02:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M6QeCNKIKk/Listeners', 02:08:03 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 02:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:03 INFO - 'USER': 'cltbld', 02:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:03 INFO - 'XPC_FLAGS': '0x0', 02:08:03 INFO - 'XPC_SERVICE_NAME': '0', 02:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:04 INFO - Downloading/unpacking jsonschema 02:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:08:06 INFO - Downloading/unpacking functools32 (from jsonschema) 02:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:06 INFO - Downloading functools32-3.2.3-2.tar.gz 02:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:08:06 INFO - warning: no files found matching '*.txt' 02:08:06 INFO - no previously-included directories found matching 'build' 02:08:06 INFO - no previously-included directories found matching 'dist' 02:08:06 INFO - no previously-included directories found matching '.git*' 02:08:06 INFO - Installing collected packages: jsonschema, functools32 02:08:07 INFO - Running setup.py install for functools32 02:08:07 INFO - warning: no files found matching '*.txt' 02:08:07 INFO - no previously-included directories found matching 'build' 02:08:07 INFO - no previously-included directories found matching 'dist' 02:08:07 INFO - no previously-included directories found matching '.git*' 02:08:07 INFO - Successfully installed jsonschema functools32 02:08:07 INFO - Cleaning up... 02:08:07 INFO - Return code: 0 02:08:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:07 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 0x107531a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d967e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x107239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073ccb20>, '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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:08:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hBVv1qKhv/Render', 02:08:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:07 INFO - 'HOME': '/Users/cltbld', 02:08:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:07 INFO - 'LOGNAME': 'cltbld', 02:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:07 INFO - 'MOZ_NO_REMOTE': '1', 02:08:07 INFO - 'NO_EM_RESTART': '1', 02:08:07 INFO - 'PAGER': '/bin/cat', 02:08:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:07 INFO - 'PWD': '/builds/slave/test', 02:08:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:07 INFO - 'SHELL': '/bin/bash', 02:08:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M6QeCNKIKk/Listeners', 02:08:07 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 02:08:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:07 INFO - 'USER': 'cltbld', 02:08:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:07 INFO - 'XPC_FLAGS': '0x0', 02:08:07 INFO - 'XPC_SERVICE_NAME': '0', 02:08:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:07 INFO - Downloading/unpacking flake8 02:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:08:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:08:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:08:11 INFO - no previously-included directories found matching 'docs/_build' 02:08:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:08:11 INFO - Running setup.py install for pep8 02:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:08:11 INFO - no previously-included directories found matching 'docs/_build' 02:08:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:08:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:08:11 INFO - Cleaning up... 02:08:11 INFO - Return code: 0 02:08:11 INFO - Running post-action listener: _resource_record_post_action 02:08:11 INFO - Running post-action listener: _start_resource_monitoring 02:08:11 INFO - Starting resource monitoring. 02:08:11 INFO - ##### 02:08:11 INFO - ##### Running install step. 02:08:11 INFO - ##### 02:08:11 INFO - Running pre-action listener: _resource_record_pre_action 02:08:11 INFO - Running main action method: install 02:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:11 INFO - Reading from file tmpfile_stdout 02:08:11 INFO - Detecting whether we're running mozinstall >=1.0... 02:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:08:11 INFO - Reading from file tmpfile_stdout 02:08:11 INFO - Output received: 02:08:11 INFO - Usage: mozinstall [options] installer 02:08:11 INFO - Options: 02:08:11 INFO - -h, --help show this help message and exit 02:08:11 INFO - -d DEST, --destination=DEST 02:08:11 INFO - Directory to install application into. [default: 02:08:11 INFO - "/builds/slave/test"] 02:08:11 INFO - --app=APP Application being installed. [default: firefox] 02:08:11 INFO - mkdir: /builds/slave/test/build/application 02:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:08:43 INFO - Reading from file tmpfile_stdout 02:08:43 INFO - Output received: 02:08:43 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:08:43 INFO - Running post-action listener: _resource_record_post_action 02:08:43 INFO - ##### 02:08:43 INFO - ##### Running run-tests step. 02:08:43 INFO - ##### 02:08:43 INFO - Running pre-action listener: _resource_record_pre_action 02:08:43 INFO - Running main action method: run_tests 02:08:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:08:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:08:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:08:43 INFO - 2016-03-12 02:08:43.672 screenresolution[1929:13203] starting screenresolution argv=screenresolution get 02:08:43 INFO - 2016-03-12 02:08:43.675 screenresolution[1929:13203] Display 0: 1600x1200x32@60 02:08:43 INFO - 2016-03-12 02:08:43.680 screenresolution[1930:13205] starting screenresolution argv=screenresolution list 02:08:43 INFO - Available Modes on Display 0 02:08:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:08:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:08:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:08:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:08:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:08:43 INFO - Intel Iris: 02:08:43 INFO - Chipset Model: Intel Iris 02:08:43 INFO - Type: GPU 02:08:43 INFO - Bus: Built-In 02:08:43 INFO - VRAM (Dynamic, Max): 1536 MB 02:08:43 INFO - Vendor: Intel (0x8086) 02:08:43 INFO - Device ID: 0x0a2e 02:08:43 INFO - Revision ID: 0x0009 02:08:43 INFO - Displays: 02:08:43 INFO - Display: 02:08:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:08:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:08:43 INFO - Display Serial Number: 1600x1200 60 02:08:43 INFO - Main Display: Yes 02:08:43 INFO - Mirror: Off 02:08:43 INFO - Online: Yes 02:08:43 INFO - Rotation: Supported 02:08:43 INFO - Return code: 0 02:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:08:43 INFO - Python 2.7.3 02:08:43 INFO - Return code: 0 02:08:43 INFO - grabbing minidump binary from tooltool 02:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:43 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 0x1073d5d30>, '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 0x107239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073ccb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:08:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:08:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:08:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:08:43 INFO - Return code: 0 02:08:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:08:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:08:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:08:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:08:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:08:45 INFO - Return code: 0 02:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0166', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0166 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:08:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hBVv1qKhv/Render', 02:08:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:45 INFO - 'HOME': '/Users/cltbld', 02:08:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:45 INFO - 'LOGNAME': 'cltbld', 02:08:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:08:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:45 INFO - 'MOZ_NO_REMOTE': '1', 02:08:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:08:45 INFO - 'NO_EM_RESTART': '1', 02:08:45 INFO - 'PAGER': '/bin/cat', 02:08:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:45 INFO - 'PWD': '/builds/slave/test', 02:08:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:08:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:45 INFO - 'SHELL': '/bin/bash', 02:08:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M6QeCNKIKk/Listeners', 02:08:45 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 02:08:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:45 INFO - 'USER': 'cltbld', 02:08:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:45 INFO - 'XPC_FLAGS': '0x0', 02:08:45 INFO - 'XPC_SERVICE_NAME': '0', 02:08:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0166', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:08:45 INFO - mozversion application_buildid: 20160312004006 02:08:45 INFO - mozversion application_changeset: edcc2ad52ece9427517f1bc7d1d4e9497ed479f6 02:08:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:08:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:08:45 INFO - mozversion application_name: Firefox 02:08:45 INFO - mozversion application_remotingname: firefox-dev 02:08:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:08:45 INFO - mozversion application_vendor: Mozilla 02:08:45 INFO - mozversion application_version: 47.0a2 02:08:45 INFO - mozversion platform_buildid: 20160312004006 02:08:45 INFO - mozversion platform_changeset: edcc2ad52ece9427517f1bc7d1d4e9497ed479f6 02:08:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:08:45 INFO - mozversion platform_version: 47.0a2 02:08:45 INFO - using testdate: 1457777325 02:08:45 INFO - actual date: 1457777325 02:08:45 INFO - starting webserver on 'localhost:49426' 02:08:45 INFO - SUITE-START | Running 2 tests 02:08:45 INFO - TEST-START | dromaeo_css 02:08:45 INFO - operating with platform_type : mac_ 02:08:45 INFO - Initialising browser for dromaeo_css test... 02:08:45 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpNrIb7J/profile http://localhost:49426/getInfo.html) 02:08:47 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 02:08:47 INFO - PROCESS | 1948 | colorDepth:24 02:08:47 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 02:08:47 INFO - PROCESS | 1948 | __metrics 02:08:47 INFO - PROCESS | 1948 | 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" 02:08:47 INFO - PROCESS | 1948 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:08:48 INFO - TEST-INFO | 1948: exit 0 02:08:48 INFO - Browser initialized. 02:08:48 INFO - Running cycle 1/1 for dromaeo_css test... 02:08:48 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpNrIb7J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:09:00 INFO - PROCESS | 1951 | RSS: Main: 210673664 02:09:00 INFO - PROCESS | 1951 | 02:09:51 INFO - PROCESS | 1951 | 1457777391656 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:12:02 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49426/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49426/tests/dromaeo/cssquery-ext.html) 02:12:03 INFO - PROCESS | 1951 | RSS: Main: 345239552 02:12:03 INFO - PROCESS | 1951 | 02:15:05 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49426/tests/dromaeo/cssquery-ext.html (next: http://localhost:49426/tests/dromaeo/cssquery-jquery.html) 02:15:06 INFO - PROCESS | 1951 | RSS: Main: 337367040 02:15:06 INFO - PROCESS | 1951 | 02:18:08 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49426/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49426/tests/dromaeo/cssquery-mootools.html) 02:18:08 INFO - PROCESS | 1951 | RSS: Main: 344756224 02:18:08 INFO - PROCESS | 1951 | 02:21:10 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49426/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49426/tests/dromaeo/cssquery-prototype.html) 02:21:11 INFO - PROCESS | 1951 | RSS: Main: 306659328 02:21:11 INFO - PROCESS | 1951 | 02:24:14 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49426/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49426/tests/dromaeo/cssquery-yui.html) 02:24:14 INFO - PROCESS | 1951 | RSS: Main: 308678656 02:24:14 INFO - PROCESS | 1951 | 02:27:17 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49426/tests/dromaeo/cssquery-yui.html (next: http://localhost:49426/tests/dromaeo/cssquery-dojo.html) 02:27:17 INFO - PROCESS | 1951 | RSS: Main: 360288256 02:27:17 INFO - PROCESS | 1951 | 02:27:17 INFO - PROCESS | 1951 | __start_tp_report 02:27:17 INFO - PROCESS | 1951 | _x_x_mozilla_page_load 02:27:17 INFO - PROCESS | 1951 | _x_x_mozilla_page_load_details 02:27:17 INFO - PROCESS | 1951 | |i|pagename|runs| 02:27:17 INFO - PROCESS | 1951 | |0;dojo.html;3397.048826328628;3496.5629296337975;3512;3517.120719820045;3539.734519911006;5728;5739.684317362543;5743.253377060987;5766.308043034836;5814.883702325951;5817.912731309023;5853.356130825617;5856.180134781123;5866.589338746289;5870.47165755083;5095.286659867622;5169.30214421054;5181.844544663666;5200.245964335169;5284.550813180865;5306.681599104047;5309.787608495655;5312.229726689628;5317.734113294339;5318.30861987943;5147.330846989905;5191.299174611436;5195.298634684326;5229.372475302969;5311.336082989626;5252.422233554306;5317.574594032488;5325.147976323769;5334.146536554172;5353.892922141536;5042.697438153723;5226.764795584208;5238.266642670029;5238.554722848562;5240.34495688039;5635.971820140873;5718.1136923776885;5735.627184233053;5739.110437882135;5747.3677895431465;6123.9387606124255;6204.906926396107;6211.0372892201785;6222.408871157233;6231.626102433823;6146.416090471398;6161.4146656067605;6223.844403889939;6237.438630523229;6291.937080629181;5948.464638182541;5964.731587078549;5967;5974.850628734316;5976.641401515923;6177.598456100339;6313.715882785285;6318.052292156213;6319.747210111636;6342.397472240222;6124.989376752875;6157.599756015845;6182.103594978703;6192.969035154795;6268.749250030039;6279.403456671609;6279.403456671609;6286.748530058747;6293.339199383999;6299.149614802035;6230.688465576703;6276.215473065867;6281.528885333618;6292.968535157386;6298.622082675054;5212.452692467236;6174.25908890936;6226.439620434092;6249.437550620466;6286.591371560834;4915.016996600694;4918.803247870117;4948.851534453972;4952;4954.752262386866;4433.645308375322;4474.993126546501;4521;4539.546045395434;4542.295944128599;5766.04860198071;5818.650880947157;5824.097264923944;5830.941690583125;5872.383399742966;6179.752809887555;6257.030160325156;6260.530460215411;6266.122742816009;6274.309825919146;5725.141228815711;5815.88368232633;5823.068309070613;5838.7080645967535;5847.152162936351;5411.485908838654;5425.891482170335;5428.9185662215095;5430.56555475561;5434.184872269112;6242.812715618538;6337.7781777637565;6377.17096777416;6404.871902561923;6417.614943103429;6207.224096987877;6231;6263.749450021948;6268.780592679417;6272.18461599989;6364.268109167319;6373.139626150596;6377.681115944277;6385.489160867212;6400.679966001774;6133.049377346519;6139.706800529493;6151.138840562236;6277.309495955533;6281.96859015702;6232.127502149793;6240;6240.625562466266;6255.40573645503;6257.56197066201;6200.627962322275;6203.534734894811;6206.813795586139;6215.9378406215355;6225.968870155621;5938.851528711817;6142.232220972379;6205.968970155301;6221.688915554295;6238.968805155945;6022.316298459343;6049.971504844275;6059.3637668045985;6060.363661815446;6102.1762062122825;5060.443351231435;6172.475339596184;6178.938210617836;6186.319504854552;6193.721282542387;5982.312034116132;6011.909821352596;6115.449609535163;6116.445413412548;6120.08198770188 02:27:17 INFO - PROCESS | 1951 | |1;ext.html;471.99056018879645;579.7130370577316;585.096026638843;670.8322919270182;671.2951401028921;31982.36035279296;40044.1991160177;40509.59490405095;40525.39211911824;40551;43679.78160109203;44230.115397692105;44345.1130977381;44347.556524434745;44414;9577.281703872202;9820.459874706889;9821.116099551038;9828.164606008462;9847.65533206338;9618.038196180396;9768.218542516617;9776.413415195075;9781;9781.559829807677;9693.273004524688;9865.950670246639;9869.703908882744;9875.753106172331;9921.35511191774;9797.412155270707;9846.458444785534;9849.753756156082;9849.90150098497;9853.605855765796;9682.080202380834;9819.754506137333;9827.90172098277;9829.164521015722;9837.508124593813;42132.78933605343;42613.57386426127;42637.36043959343;42690.15788579043;42712.78643606762;3281.868725250987;3451.7238620910266;3453.3783918894587;3476.7566270361085;3919.176972835708;29047.41905161906;29270.70729292701;29490.852545737347;30082.398352032837;30152.698473015207;2781.624480695121;2815.6339675842214;2839;2849.202223377458;2860.013295413079;370198;372468;372933;373027;373350;46943;47566.76216618964;66349.66825165843;66709.33290667032;67087;46706.299405508944;46777.766111169905;46979.76510117428;47041;47143.76428117837;16764.497065088068;16859.915700421418;16879.40922067722;16907.661846762996;16931.492055238115;13232;13281.867181328256;13284.667883302995;13310.401031953585;13313.134646247963;13007.804882926574;15112;15382.3077961492;15395.230238488031;15401.922990385201;6499.2200935887995;6672.232693240242;6684.699188536528;6719.462443004548;6745.7976260711275;974.5370948799406;981.3032746749888;992.7369247149511;1085.9574808184075;1117.407773879845;30224.395512089635;30487.390252195277;30657.846710766302;30823.524733577276;30937;1012.8480727890875;1064.7604289034905;1103.773726386089;1120.7982563138714;1130.2596799096605;13203.735925281633;15362;15522;15586.454474093352;15632.039551063615;550980;553691;558380;559973;560828;60940.781184376065;61501.69249153726;61533;61804;61810.38189618136;1490.1059364381501;1513.9015963962306;1526.213999790109;1554.518099389193;1557.914314712679;28735;29441.96953106631;30007.699923001364;30040;30753.231169220948;48213.55359339225;48780;49052;49059.77350566264;49243.26135108048;374860;377169;377257;377744;378286;25021.249362519153;33821.492677610346;34916.47625285572;34981.82509087438;35050.12374690653;41629.375559366024;42546;42576.5742342585;42889.35665964951;44142.558574413844;28114.29714257078;34126.146846329044;36540.53837846563;37826.43260351152;38193.80903095467;36751;36903.63096369002;37220.62779372172;37799.43300850435;38218;36687;37028.25943481169;37153.07117322089;37500;37804.62195378011;31890;33027.504587430725;33216;33239;33422.665773341956;24806.25581232566;25141.24576262715;25168;25571.872140639178;25689.87155064213 02:27:17 INFO - PROCESS | 1951 | |2;jquery.html;295.5360084667073;372.184915036071;372.23691432563254;379.63554987212274;384.34469229962883;20253.291134810286;20826.89586552067;20840.583188336223;21265.468363290885;21267.57464850702;12090.790920907904;12495.000399968003;12499.687507812308;12499.875001249984;12503.06227032974;5103.591712662978;5256.8160114395905;5921.437463440966;5938.346781853993;5941.227640406741;5781.132830075501;5818.854528636797;5823.563232757539;5840.532757379399;5844.1818145459665;5542.889142217154;5786.942130578704;5794.68129252891;5820.679862607555;5862.736176872029;5774.769009239625;5804.448577385163;5812.709364531777;5819.592628516006;5822.0684690449325;5017.54842064216;5071.366079240095;5112.769925353368;5116.462771408986;5152.587792976553;13890.861091389159;14029.85970140306;14217.289135543182;15146.772798408032;26104.477910441874;2126.9787302126933;2222.288867562381;2251.4934139818574;2653.761161495475;2897.1018984114994;9377.296702747253;10388.532516036796;10495.370277783357;10522.473876306154;10539.314944528582;1703.7699910512047;1803.251650565014;1890.4990177602947;1893.2994791927076;1978.485593745622;105029.94970050278;109440;110594.44702776434;111576.4421177897;113829.29256061166;9802.122396872262;10319.690409287734;11816.88183118175;11890.46492907804;12068.577599783965;14448.205348705711;14469.493567725289;14476.203808790407;14537.563873083824;14560.563183104523;7482.289182527651;9030.683926062688;9099.454032758056;9102.271818254523;9181.954090229507;6692.498062645321;7545.773626791205;8969.058248883774;9318;9500.857487137699;4578.221702310615;4667.416572928384;4669.159551280802;4675.95324046762;4708.623310135181;1926.730257763914;1966.5575245569632;1976.960460790776;1977.3474753331366;1986.9304574340117;872.7294538693026;937.4937533731709;963.802420503795;1011.9797604047877;1018.7504061504978;19166.616667666567;20908.16367345289;20924.790752092587;20951.580968380546;20983.95080246012;967.3180407812475;1010.3887148275188;1032.3444612670858;1032.9690109296732;1061.2200032975757;9410.01194874542;10711.678649640524;10913.39976301311;11153.051990580729;11156.944215279034;563902;602132;679760.6011970007;698942;699994;105346;109953.45023274992;113359;129776;135068;1014.7919676466307;1042.296449896317;1058.2539309786582;1059.6132411669685;1060.9628662996759;17646.823531765032;17680.64638707193;17754.37859674905;18185.45443636693;18343.724844127617;40887.77336679905;45154.09691806211;47128.29307560321;48257.55227343185;49641;70033;70840;71057.64471177818;71881.6405917967;72018.63990680013;7864.410169237216;7987.64055617487;8022.358211343195;8066;8384.916150838413;13115;13381.464741410235;13478.79781803254;13785.103968242032;13791.448342066205;9902;11594.826077609012;11706.297622142698;11732.589359372381;11767.999720023894;11656.825147622962;11680.94159529197;11731.296122232694;11760.176787625127;11919.642410727693;11930.105242106703;11940.582079627171;11986.101042422028;12104.636860894187;12124.454399552218;8220.3834712398;8223.712170074019;8432.789180270542;8511.702090426805;8549.230569248797;8885.644574217218;9991.100800927952;11674.649760507198;11692.94153529261;11885.702857428634 02:27:17 INFO - PROCESS | 1951 | |3;mootools.html;1503.0305452982834;1629.1039928039577;1659.0709202846406;1976.347805224276;2047.692846073089;7702.96148519258;8294.419390642657;8906.77733056674;9101;9145.496997665126;8674.653013879437;8933.687320943769;8935.195832375084;8967.551622418885;8968.596413161407;2243.9663405048855;2404.8076153907646;2437.8659173745436;2541.2122242104915;2571.7556832101013;2468.3705655057934;2479.466914613358;2483.056438553347;2483.950320993579;2486.0552989863827;2352.847064940782;2524.4572416930355;2542.9745702542923;2544.2875994721417;2544.5038217547585;2522.318973877052;2564.7178810330847;2565.756253155947;2566.47387285606;2570.447353818919;2530;2561.756633119869;2564.217913536371;2568.895374988773;2569.961450578243;8976.281897448189;9037.322200834898;9040.728778136667;9044.10073884485;9061.773455663595;5549.056660367747;5710.543156547466;5710.685912274823;5716.42835716425;5732.168835518868;3633.3096711624707;3688.0595448160816;3777.0557360659836;3783.3379158647404;3797.7721336719887;1062.8990245926625;1070.4166229404993;1079.983800242997;1095.3044816541474;1116.7040734205361;12371;12388.256704597752;12406.379681016004;12408.069394795337;12434.316112613802;5010.949890501121;5018.146915024455;5086.949130508721;5092.210707340369;5107.9489205107475;9544.045595440539;9864.802703946025;10490.423026733602;10504.842427363596;10506.474676266156;4871.634627402959;5679.204911312337;5679.5172410345585;5680.4319568042865;5691.516221121168;4529.479109902338;4716.716996980193;4970.453250142481;5044;5074.340335756328;4063.8463098435286;4108.979455102765;4143.3370660694145;4175.83296668136;4178.874633760931;1337.8260826092546;1355.5594431809504;1363.6659018540322;1376.2430663135235;1379.661982814217;1040.458961340099;1041.432419331451;1139.5214010115772;1156.9537218511334;1229.8155276708387;8411.158884111539;8433.451825631315;8437.746867593982;8506.149385061444;8509.234168924826;530.4456842599493;535.4484880573016;542.3275138827825;542.7421974562052;544.1076634319719;6230.813075607648;6295.5907865988565;6306.0225665022;6318.810435686937;6319;10331.380117192992;10947.397893115955;10958;10973.957474039953;10975.890241097646;10346.068853803194;10724.78550428987;10741.51663175159;10804.973527514874;10825.512851921683;8177.795555111051;8316.043654979634;8371.372147088992;8376.455530390505;8376.539290338967;7940.761777146695;7945.6027198640995;7954.761357159295;8215.58922053883;8330.833383332421;9620.663276785279;9622.37454565451;9665.71002869915;9701.951490242503;9769.902300977183;9872.901270987199;9998.95011023832;10015.949920250352;10091.899081009096;10121.746956326151;6948.6525673715105;7039.472039596948;7622.31399174077;7706.460547761827;7864.252895974873;8448.746537603882;8480.491170529542;8520.786980325542;8527.488350698977;8537.82924341522;7392.26077392278;7554;7622.5426474411715;7666.9616651916385;7695.692172313269;7436.888446673196;7483.32650061497;7501.962490187514;7504.986826778315;7601.049868766404;8051.1546287641295;8077.03075630928;8086.231807978233;8101.959490202511;8110.188981101843;7249.963750181215;7279.490435669452;7359.668814903235;7422.25777422275;7429.665665045194;7426.777196684108;7447.106347238366;7480.925190748023;7487.588182650006;7494.17564067963 02:27:17 INFO - PROCESS | 1951 | |4;prototype.html;332.7339473304078;337.58477073199964;342.175357388693;344.107042225425;347.7131366622537;6491.156149700532;6494.740210391585;6543.280239173693;6547.279799222094;6555.3772391622715;6422.454091402225;6460.741570337181;6477.967610161954;6479.870402591957;6480.287168411471;4588.242939914927;4640.767961601923;4724.503927087658;4781.760911954406;4851.393575803016;4298.743159841093;4425.424694789689;4766.594839438634;4830.154722923475;4848.17581011229;4772.451168115676;4780.880477988061;4781.115493633672;4801.951980480186;4803.18345881201;4526.524714904937;4613.5847773700525;4776.426828780569;4807.230843065127;4811.137373262903;3439.8968030959113;4143.4199212110325;4150;4152.896177595554;4165.000399904032;6161.568690191689;6165.876682466325;6172.7530898764;6183.690815459209;6186.474149697281;5650.858728531778;5656.575756818214;5662.773489060432;5674.801381951653;5683.2895888014;5536.695481748502;6898.344657257552;6904.378605925491;6912.274211207801;6917.169939607279;4330.437043184366;4476.261416866213;4477.888052798674;4480.283154695266;4483.618892394118;6970.825729356756;7151.249118842498;7184.137903451567;7214.63926803663;7245.963770181115;4605.746683932349;4610.95389046112;4623.283391074388;4626.259798432302;4634.629229661687;4662.114198302312;4669.906601868011;4679.766011699401;4681.789319480631;4686.625069994392;5507.834764957058;5512.641678290898;5524.281843360418;5526.226328314039;5532.474414930575;5651.858703532363;6652.634105124264;6888.138982627172;6954.756583519654;6962.825929351807;1610.5892997285616;1616.7009103315688;1627.0725686358899;1629.8940568862986;1630.7879975603096;990.7225976726528;1020.4846552491093;1046.4035499765214;1049.3231865446896;1070.5182667799365;4781.545753153445;5826.436367998067;6014.947384207746;6400.519961002943;6422.068800023971;7211.819704507429;7213.062301900824;7218;7222.422206223489;7245.985562021321;6414.679266036679;6428.903566446507;6434.195725534309;6437.839054023687;6459.935400646027;3740.663340299386;3790.5451345838123;3791.374423220138;3792.60177681345;3793.7534060285993;7199.06412166415;7469.813254668568;7482.5884576347735;7506.28690274423;7514.586697731677;7362.815929601803;7371.88942165868;7431.665575049135;7444.367228785505;7464.738734144387;7463.179050304462;7468.5145465544565;7474.850502990019;7492.887606685795;7493.66278517468;6947.096877405905;7194.784156475314;7206.991021257133;7215.530990485601;7217.530860494051;7086.39765619928;7118.039064726196;7121.359077683033;7121.4302855770375;7130.108736407949;7398.630068496446;7446.553206807609;7447.106347238366;7472.887906681295;7475;4628.39830821991;4644.187267228289;4652.488226295037;4655.673133157034;4660.13787449323;7140.250273721184;7140.321669441395;7152.642367881481;7160.964195178991;7162.355388015104;6625.933740662532;6946.131733533309;6959.965200173967;6963.825904352431;6969.7909062728195;6888.965555172192;6919.861602768017;6946.305369463013;6954.79135625932;6968.163820341591;6755.7973260802255;6764.323567643196;6787.355201255873;6787.762428314985;6799.694013769491;6078.483328917092;6102.603330783485;6215.906761398673;6269.279032911274;6512.762575110713;6019.458248757458;6538.019297105472;6592.8351791205605;6756.358145976124;6800.285969973082 02:27:17 INFO - PROCESS | 1951 | |5;yui.html;608.8569186241233;711.0649495912877;785.5169071021322;792.1125811072718;807.2331285278983;15428.382864685413;15521.068735875855;15591.922040389782;15593.766093508606;15618.531444056682;14370.568882933503;14413.063150895185;14466.710665786677;14473.78289325661;14483.058601190914;794.3684770607352;804.8108694456798;942.6936245720168;956.1585804492038;990.5146478225689;965.2085290062151;974.4835237324229;977.7506735782365;979.6424305128612;980.446047982891;1051.5215576912524;1056.0759335581367;1063.0538820449767;1063.2291588598243;1064.276292121357;828.693383448125;999.8400255959048;1037.667946257198;1039.5893622019335;1040.8542804007445;773.5822655765879;775.6315750018696;776.8679324514846;776.9922300776976;778.4823092643385;15401.460948866848;15407.306671199824;15457.690846183013;15471.767923481157;15472.535823925187;12842.293673847935;13110.344482775918;13160.341982900816;13171.802422963663;13699.287589051368;10174.236932230038;10286.7428314292;10351.741206469824;10456.68629941103;10972.670819875417;4077.673786097105;4147.232761939021;4170.687198460128;4191.790410479463;4270.658347332206;77630.6118469404;78637;79062;79502.60248698719;79992.60003699944;9633.181179599813;9766.121049105472;9795.657151999789;9829.115379615869;10497;19040.61918761617;24238.15166469165;24521.340945220352;24570;24572.754272457405;7737.381009519225;7876.921230787733;7886.408519360956;8007.239312265326;8278.586070696441;3377.5778027746533;3931.4495970564144;3937.1731936293127;3979.8408063677707;4055.351143817034;3701.5373078365205;3750.6061863503937;3754.6433088856515;3756.4365345197893;3769.076576238784;565.6832173982501;608.2974164839617;618.0482057631198;679.5107522583731;693.5942473652868;597.1192491075628;600.7596961215548;604.1813342920368;613.9508839292846;624.4161708802285;8167.591620418955;8241.423100383035;8389.161083891684;8413.158684131538;8654.783630409163;599.241958921964;600.7056542294332;602.9427204415573;624.1231070346171;626.1640709652573;3905.1213476968023;3965.325894597925;3984.8406063757707;4007.599240075969;4114.588541145861;96029.5595566067;98970.17453567781;99515;100583;100787;82652.17347826445;87873;88161.55919220363;89628.5518572416;89919.55040224757;74649;76720.84918726224;77265.6136719324;78804;79034.20965790383;7976.441649084509;8058.113607503287;8061.87907181381;8146.9185308148535;8223.629936652746;53344.4665553355;53406.73296633492;53483.19775203453;53976;54003.72998135141;68881;69221.30778692149;69223.65388173026;71474.64262678653;71612.64193678998;11304.43477826089;11435.59975400857;11460.541578336773;11701.94682478581;11967.982721468772;12107.878921210675;12278.017758579113;12284.938575307066;12566.937165314115;12657.367131643565;11854.051675866083;12010.459529321026;12082.879171208528;12196.146269761386;12251.38743062861;9375.85936210971;11790.528378864748;11848.229865058744;11866.347350895783;12679.55621553278;10611.31026483276;11175.55297788112;11381.772364552828;11467.025302849017;11572.24780389272;9956.651517196864;9968.202543796624;10092.444915529717;10146.49267536635;10522.473876306307;10000.749981250527;10004.499775011365;10009.649662262078;10015.863355648475;10054.19566434669 02:27:17 INFO - PROCESS | 1951 | __end_tp_report 02:27:17 INFO - PROCESS | 1951 | __start_cc_report 02:27:17 INFO - PROCESS | 1951 | _x_x_mozilla_cycle_collect,1078 02:27:17 INFO - PROCESS | 1951 | __end_cc_report 02:27:17 INFO - PROCESS | 1951 | __startTimestamp1457778437661__endTimestamp 02:27:17 INFO - PROCESS | 1951 | 02:27:17 INFO - PROCESS | 1951 | ------- Summary: start ------- 02:27:17 INFO - PROCESS | 1951 | Number of tests: 6 02:27:17 INFO - PROCESS | 1951 | 02:27:17 INFO - PROCESS | 1951 | [#0] dojo.html Cycles:165 Average:5791.43 Median:6059.36 stddev:629.84 (10.4%) stddev-sans-first:603.11 02:27:17 INFO - PROCESS | 1951 | Values: 3397.0 3496.6 3512.0 3517.1 3539.7 5728.0 5739.7 5743.3 5766.3 5814.9 5817.9 5853.4 5856.2 5866.6 5870.5 5095.3 5169.3 5181.8 5200.2 5284.6 5306.7 5309.8 5312.2 5317.7 5318.3 5147.3 5191.3 5195.3 5229.4 5311.3 5252.4 5317.6 5325.1 5334.1 5353.9 5042.7 5226.8 5238.3 5238.6 5240.3 5636.0 5718.1 5735.6 5739.1 5747.4 6123.9 6204.9 6211.0 6222.4 6231.6 6146.4 6161.4 6223.8 6237.4 6291.9 5948.5 5964.7 5967.0 5974.9 5976.6 6177.6 6313.7 6318.1 6319.7 6342.4 6125.0 6157.6 6182.1 6193.0 6268.7 6279.4 6279.4 6286.7 6293.3 6299.1 6230.7 6276.2 6281.5 6293.0 6298.6 5212.5 6174.3 6226.4 6249.4 6286.6 4915.0 4918.8 4948.9 4952.0 4954.8 4433.6 4475.0 4521.0 4539.5 4542.3 5766.0 5818.7 5824.1 5830.9 5872.4 6179.8 6257.0 6260.5 6266.1 6274.3 5725.1 5815.9 5823.1 5838.7 5847.2 5411.5 5425.9 5428.9 5430.6 5434.2 6242.8 6337.8 6377.2 6404.9 6417.6 6207.2 6231.0 6263.7 6268.8 6272.2 6364.3 6373.1 6377.7 6385.5 6400.7 6133.0 6139.7 6151.1 6277.3 6282.0 6232.1 6240.0 6240.6 6255.4 6257.6 6200.6 6203.5 6206.8 6215.9 6226.0 5938.9 6142.2 6206.0 6221.7 6239.0 6022.3 6050.0 6059.4 6060.4 6102.2 5060.4 6172.5 6178.9 6186.3 6193.7 5982.3 6011.9 6115.4 6116.4 6120.1 02:27:17 INFO - PROCESS | 1951 | 02:27:17 INFO - PROCESS | 1951 | [#1] ext.html Cycles:180 Average:58545.75 Median:207771.72 stddev:117885.59 (56.7%) stddev-sans-first:118135.65 02:27:17 INFO - PROCESS | 1951 | Values: 472.0 579.7 585.1 670.8 671.3 31982.4 40044.2 40509.6 40525.4 40551.0 43679.8 44230.1 44345.1 44347.6 44414.0 9577.3 9820.5 9821.1 9828.2 9847.7 9618.0 9768.2 9776.4 9781.0 9781.6 9693.3 9866.0 9869.7 9875.8 9921.4 9797.4 9846.5 9849.8 9849.9 9853.6 9682.1 9819.8 9827.9 9829.2 9837.5 42132.8 42613.6 42637.4 42690.2 42712.8 3281.9 3451.7 3453.4 3476.8 3919.2 29047.4 29270.7 29490.9 30082.4 30152.7 2781.6 2815.6 2839.0 2849.2 2860.0 370198.0 372468.0 372933.0 373027.0 373350.0 46943.0 47566.8 66349.7 66709.3 67087.0 46706.3 46777.8 46979.8 47041.0 47143.8 16764.5 16859.9 16879.4 16907.7 16931.5 13232.0 13281.9 13284.7 13310.4 13313.1 13007.8 15112.0 15382.3 15395.2 15401.9 6499.2 6672.2 6684.7 6719.5 6745.8 974.5 981.3 992.7 1086.0 1117.4 30224.4 30487.4 30657.8 30823.5 30937.0 1012.8 1064.8 1103.8 1120.8 1130.3 13203.7 15362.0 15522.0 15586.5 15632.0 550980.0 553691.0 558380.0 559973.0 560828.0 60940.8 61501.7 61533.0 61804.0 61810.4 1490.1 1513.9 1526.2 1554.5 1557.9 28735.0 29442.0 30007.7 30040.0 30753.2 48213.6 48780.0 49052.0 49059.8 49243.3 374860.0 377169.0 377257.0 377744.0 378286.0 25021.2 33821.5 34916.5 34981.8 35050.1 41629.4 42546.0 42576.6 42889.4 44142.6 28114.3 34126.1 36540.5 37826.4 38193.8 36751.0 36903.6 37220.6 37799.4 38218.0 36687.0 37028.3 37153.1 37500.0 37804.6 31890.0 33027.5 33216.0 33239.0 33422.7 24806.3 25141.2 25168.0 25571.9 25689.9 02:27:17 INFO - PROCESS | 1951 | 02:27:17 INFO - PROCESS | 1951 | [#2] jquery.html Cycles:180 Average:35159.06 Median:20967.77 stddev:107884.22 (514.5%) stddev-sans-first:108155.10 02:27:17 INFO - PROCESS | 1951 | Values: 295.5 372.2 372.2 379.6 384.3 20253.3 20826.9 20840.6 21265.5 21267.6 12090.8 12495.0 12499.7 12499.9 12503.1 5103.6 5256.8 5921.4 5938.3 5941.2 5781.1 5818.9 5823.6 5840.5 5844.2 5542.9 5786.9 5794.7 5820.7 5862.7 5774.8 5804.4 5812.7 5819.6 5822.1 5017.5 5071.4 5112.8 5116.5 5152.6 13890.9 14029.9 14217.3 15146.8 26104.5 2127.0 2222.3 2251.5 2653.8 2897.1 9377.3 10388.5 10495.4 10522.5 10539.3 1703.8 1803.3 1890.5 1893.3 1978.5 105029.9 109440.0 110594.4 111576.4 113829.3 9802.1 10319.7 11816.9 11890.5 12068.6 14448.2 14469.5 14476.2 14537.6 14560.6 7482.3 9030.7 9099.5 9102.3 9182.0 6692.5 7545.8 8969.1 9318.0 9500.9 4578.2 4667.4 4669.2 4676.0 4708.6 1926.7 1966.6 1977.0 1977.3 1986.9 872.7 937.5 963.8 1012.0 1018.8 19166.6 20908.2 20924.8 20951.6 20984.0 967.3 1010.4 1032.3 1033.0 1061.2 9410.0 10711.7 10913.4 11153.1 11156.9 563902.0 602132.0 679760.6 698942.0 699994.0 105346.0 109953.5 113359.0 129776.0 135068.0 1014.8 1042.3 1058.3 1059.6 1061.0 17646.8 17680.6 17754.4 18185.5 18343.7 40887.8 45154.1 47128.3 48257.6 49641.0 70033.0 70840.0 71057.6 71881.6 72018.6 7864.4 7987.6 8022.4 8066.0 8384.9 13115.0 13381.5 13478.8 13785.1 13791.4 9902.0 11594.8 11706.3 11732.6 11768.0 11656.8 11680.9 11731.3 11760.2 11919.6 11930.1 11940.6 11986.1 12104.6 12124.5 8220.4 8223.7 8432.8 8511.7 8549.2 8885.6 9991.1 11674.6 11692.9 11885.7 02:27:17 INFO - PROCESS | 1951 | 02:27:17 INFO - PROCESS | 1951 | [#3] mootools.html Cycles:180 Average:6190.71 Median:543.42 stddev:3276.53 (602.9%) stddev-sans-first:3266.78 02:27:17 INFO - PROCESS | 1951 | Values: 1503.0 1629.1 1659.1 1976.3 2047.7 7703.0 8294.4 8906.8 9101.0 9145.5 8674.7 8933.7 8935.2 8967.6 8968.6 2244.0 2404.8 2437.9 2541.2 2571.8 2468.4 2479.5 2483.1 2484.0 2486.1 2352.8 2524.5 2543.0 2544.3 2544.5 2522.3 2564.7 2565.8 2566.5 2570.4 2530.0 2561.8 2564.2 2568.9 2570.0 8976.3 9037.3 9040.7 9044.1 9061.8 5549.1 5710.5 5710.7 5716.4 5732.2 3633.3 3688.1 3777.1 3783.3 3797.8 1062.9 1070.4 1080.0 1095.3 1116.7 12371.0 12388.3 12406.4 12408.1 12434.3 5010.9 5018.1 5086.9 5092.2 5107.9 9544.0 9864.8 10490.4 10504.8 10506.5 4871.6 5679.2 5679.5 5680.4 5691.5 4529.5 4716.7 4970.5 5044.0 5074.3 4063.8 4109.0 4143.3 4175.8 4178.9 1337.8 1355.6 1363.7 1376.2 1379.7 1040.5 1041.4 1139.5 1157.0 1229.8 8411.2 8433.5 8437.7 8506.1 8509.2 530.4 535.4 542.3 542.7 544.1 6230.8 6295.6 6306.0 6318.8 6319.0 10331.4 10947.4 10958.0 10974.0 10975.9 10346.1 10724.8 10741.5 10805.0 10825.5 8177.8 8316.0 8371.4 8376.5 8376.5 7940.8 7945.6 7954.8 8215.6 8330.8 9620.7 9622.4 9665.7 9702.0 9769.9 9872.9 9999.0 10015.9 10091.9 10121.7 6948.7 7039.5 7622.3 7706.5 7864.3 8448.7 8480.5 8520.8 8527.5 8537.8 7392.3 7554.0 7622.5 7667.0 7695.7 7436.9 7483.3 7502.0 7505.0 7601.0 8051.2 8077.0 8086.2 8102.0 8110.2 7250.0 7279.5 7359.7 7422.3 7429.7 7426.8 7447.1 7480.9 7487.6 7494.2 02:27:17 INFO - PROCESS | 1951 | 02:27:17 INFO - PROCESS | 1951 | [#4] prototype.html Cycles:180 Average:5636.74 Median:6418.37 stddev:1794.51 (28.0%) stddev-sans-first:1754.83 02:27:17 INFO - PROCESS | 1951 | Values: 332.7 337.6 342.2 344.1 347.7 6491.2 6494.7 6543.3 6547.3 6555.4 6422.5 6460.7 6478.0 6479.9 6480.3 4588.2 4640.8 4724.5 4781.8 4851.4 4298.7 4425.4 4766.6 4830.2 4848.2 4772.5 4780.9 4781.1 4802.0 4803.2 4526.5 4613.6 4776.4 4807.2 4811.1 3439.9 4143.4 4150.0 4152.9 4165.0 6161.6 6165.9 6172.8 6183.7 6186.5 5650.9 5656.6 5662.8 5674.8 5683.3 5536.7 6898.3 6904.4 6912.3 6917.2 4330.4 4476.3 4477.9 4480.3 4483.6 6970.8 7151.2 7184.1 7214.6 7246.0 4605.7 4611.0 4623.3 4626.3 4634.6 4662.1 4669.9 4679.8 4681.8 4686.6 5507.8 5512.6 5524.3 5526.2 5532.5 5651.9 6652.6 6888.1 6954.8 6962.8 1610.6 1616.7 1627.1 1629.9 1630.8 990.7 1020.5 1046.4 1049.3 1070.5 4781.5 5826.4 6014.9 6400.5 6422.1 7211.8 7213.1 7218.0 7222.4 7246.0 6414.7 6428.9 6434.2 6437.8 6459.9 3740.7 3790.5 3791.4 3792.6 3793.8 7199.1 7469.8 7482.6 7506.3 7514.6 7362.8 7371.9 7431.7 7444.4 7464.7 7463.2 7468.5 7474.9 7492.9 7493.7 6947.1 7194.8 7207.0 7215.5 7217.5 7086.4 7118.0 7121.4 7121.4 7130.1 7398.6 7446.6 7447.1 7472.9 7475.0 4628.4 4644.2 4652.5 4655.7 4660.1 7140.3 7140.3 7152.6 7161.0 7162.4 6625.9 6946.1 6960.0 6963.8 6969.8 6889.0 6919.9 6946.3 6954.8 6968.2 6755.8 6764.3 6787.4 6787.8 6799.7 6078.5 6102.6 6215.9 6269.3 6512.8 6019.5 6538.0 6592.8 6756.4 6800.3 02:27:17 INFO - PROCESS | 1951 | 02:27:17 INFO - PROCESS | 1951 | [#5] yui.html Cycles:180 Average:19322.40 Median:4181.24 stddev:27400.03 (655.3%) stddev-sans-first:27440.86 02:27:17 INFO - PROCESS | 1951 | Values: 608.9 711.1 785.5 792.1 807.2 15428.4 15521.1 15591.9 15593.8 15618.5 14370.6 14413.1 14466.7 14473.8 14483.1 794.4 804.8 942.7 956.2 990.5 965.2 974.5 977.8 979.6 980.4 1051.5 1056.1 1063.1 1063.2 1064.3 828.7 999.8 1037.7 1039.6 1040.9 773.6 775.6 776.9 777.0 778.5 15401.5 15407.3 15457.7 15471.8 15472.5 12842.3 13110.3 13160.3 13171.8 13699.3 10174.2 10286.7 10351.7 10456.7 10972.7 4077.7 4147.2 4170.7 4191.8 4270.7 77630.6 78637.0 79062.0 79502.6 79992.6 9633.2 9766.1 9795.7 9829.1 10497.0 19040.6 24238.2 24521.3 24570.0 24572.8 7737.4 7876.9 7886.4 8007.2 8278.6 3377.6 3931.4 3937.2 3979.8 4055.4 3701.5 3750.6 3754.6 3756.4 3769.1 565.7 608.3 618.0 679.5 693.6 597.1 600.8 604.2 614.0 624.4 8167.6 8241.4 8389.2 8413.2 8654.8 599.2 600.7 602.9 624.1 626.2 3905.1 3965.3 3984.8 4007.6 4114.6 96029.6 98970.2 99515.0 100583.0 100787.0 82652.2 87873.0 88161.6 89628.6 89919.6 74649.0 76720.8 77265.6 78804.0 79034.2 7976.4 8058.1 8061.9 8146.9 8223.6 53344.5 53406.7 53483.2 53976.0 54003.7 68881.0 69221.3 69223.7 71474.6 71612.6 11304.4 11435.6 11460.5 11701.9 11968.0 12107.9 12278.0 12284.9 12566.9 12657.4 11854.1 12010.5 12082.9 12196.1 12251.4 9375.9 11790.5 11848.2 11866.3 12679.6 10611.3 11175.6 11381.8 11467.0 11572.2 9956.7 9968.2 10092.4 10146.5 10522.5 10000.7 10004.5 10009.6 10015.9 10054.2 02:27:17 INFO - PROCESS | 1951 | -------- Summary: end -------- 02:27:17 INFO - PROCESS | 1951 | 02:27:18 INFO - TEST-INFO | 1951: exit 0 02:27:18 INFO - TEST-OK | dromaeo_css | took 1112811ms 02:27:18 INFO - TEST-START | kraken 02:27:18 INFO - operating with platform_type : mac_ 02:27:18 INFO - Initialising browser for kraken test... 02:27:18 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpieYqMm/profile http://localhost:49426/getInfo.html) 02:27:20 INFO - PROCESS | 1955 | __metrics Screen width/height:1600/1200 02:27:20 INFO - PROCESS | 1955 | colorDepth:24 02:27:20 INFO - PROCESS | 1955 | Browser inner width/height: 1024/689 02:27:20 INFO - PROCESS | 1955 | __metrics 02:27:20 INFO - PROCESS | 1955 | 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" 02:27:20 INFO - PROCESS | 1955 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:27:21 INFO - TEST-INFO | 1955: exit 0 02:27:21 INFO - Browser initialized. 02:27:21 INFO - Running cycle 1/1 for kraken test... 02:27:21 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpieYqMm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:32 INFO - PROCESS | 1958 | RSS: Main: 210796544 02:27:32 INFO - PROCESS | 1958 | 02:27:35 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49426/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49426/tests/kraken/driver.html?testName=audio-beat-detection) 02:27:36 INFO - PROCESS | 1958 | RSS: Main: 264814592 02:27:36 INFO - PROCESS | 1958 | 02:27:38 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49426/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49426/tests/kraken/driver.html?testName=audio-dft) 02:27:39 INFO - PROCESS | 1958 | RSS: Main: 276324352 02:27:39 INFO - PROCESS | 1958 | 02:27:42 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49426/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49426/tests/kraken/driver.html?testName=audio-fft) 02:27:42 INFO - PROCESS | 1958 | RSS: Main: 265457664 02:27:42 INFO - PROCESS | 1958 | 02:27:44 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49426/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49426/tests/kraken/driver.html?testName=audio-oscillator) 02:27:45 INFO - PROCESS | 1958 | RSS: Main: 265461760 02:27:45 INFO - PROCESS | 1958 | 02:27:47 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49426/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49426/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:27:48 INFO - PROCESS | 1958 | RSS: Main: 268111872 02:27:48 INFO - PROCESS | 1958 | 02:27:50 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49426/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49426/tests/kraken/driver.html?testName=imaging-darkroom) 02:27:51 INFO - PROCESS | 1958 | RSS: Main: 267104256 02:27:51 INFO - PROCESS | 1958 | 02:27:54 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49426/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49426/tests/kraken/driver.html?testName=imaging-desaturate) 02:27:54 INFO - PROCESS | 1958 | RSS: Main: 268402688 02:27:54 INFO - PROCESS | 1958 | 02:27:57 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49426/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49426/tests/kraken/driver.html?testName=json-parse-financial) 02:27:58 INFO - PROCESS | 1958 | RSS: Main: 268070912 02:27:58 INFO - PROCESS | 1958 | 02:27:59 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49426/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49426/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:28:00 INFO - PROCESS | 1958 | RSS: Main: 300793856 02:28:00 INFO - PROCESS | 1958 | 02:28:02 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49426/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49426/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:28:02 INFO - PROCESS | 1958 | RSS: Main: 300683264 02:28:02 INFO - PROCESS | 1958 | 02:28:04 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49426/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49426/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:28:05 INFO - PROCESS | 1958 | RSS: Main: 308088832 02:28:05 INFO - PROCESS | 1958 | 02:28:08 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49426/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:28:08 INFO - PROCESS | 1958 | RSS: Main: 310673408 02:28:08 INFO - PROCESS | 1958 | 02:28:11 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:28:11 INFO - PROCESS | 1958 | RSS: Main: 310706176 02:28:11 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:49426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49426/tests/kraken/driver.html?testName=ai-astar) 02:28:13 INFO - PROCESS | 1958 | RSS: Main: 371220480 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | __start_tp_report 02:28:13 INFO - PROCESS | 1958 | _x_x_mozilla_page_load 02:28:13 INFO - PROCESS | 1958 | _x_x_mozilla_page_load_details 02:28:13 INFO - PROCESS | 1958 | |i|pagename|runs| 02:28:13 INFO - PROCESS | 1958 | |0;ai-astar;111;108;110;109;111;111;119;111;109;109 02:28:13 INFO - PROCESS | 1958 | |1;audio-beat-detection;154;119;142;153;116;138;115;150;145;114 02:28:13 INFO - PROCESS | 1958 | |2;audio-dft;182;185;183;186;186;186;184;184;186;188 02:28:13 INFO - PROCESS | 1958 | |3;audio-fft;70;79;74;115;55;57;57;58;118;55 02:28:13 INFO - PROCESS | 1958 | |4;audio-oscillator;92;91;131;79;77;87;121;76;79;117 02:28:13 INFO - PROCESS | 1958 | |5;imaging-gaussian-blur;86;83;87;84;87;83;87;83;86;83 02:28:13 INFO - PROCESS | 1958 | |6;imaging-darkroom;92;93;106;148;149;92;92;92;92;91 02:28:13 INFO - PROCESS | 1958 | |7;imaging-desaturate;87;84;85;87;86;84;91;116;83;87 02:28:13 INFO - PROCESS | 1958 | |8;json-parse-financial;57;58;58;58;57;56;59;69;50;51 02:28:13 INFO - PROCESS | 1958 | |9;json-stringify-tinderbox;64;61;68;75;74;69;69;69;97;98 02:28:13 INFO - PROCESS | 1958 | |10;stanford-crypto-aes;81;80;81;80;80;80;79;80;82;83 02:28:13 INFO - PROCESS | 1958 | |11;stanford-crypto-ccm;138;124;129;115;127;105;124;124;123;123 02:28:13 INFO - PROCESS | 1958 | |12;stanford-crypto-pbkdf2;133;122;134;132;131;121;132;132;129;131 02:28:13 INFO - PROCESS | 1958 | |13;stanford-crypto-sha256-iterative;64;65;66;65;67;67;67;67;64;67 02:28:13 INFO - PROCESS | 1958 | __end_tp_report 02:28:13 INFO - PROCESS | 1958 | __start_cc_report 02:28:13 INFO - PROCESS | 1958 | _x_x_mozilla_cycle_collect,1194 02:28:13 INFO - PROCESS | 1958 | __end_cc_report 02:28:13 INFO - PROCESS | 1958 | __startTimestamp1457778493633__endTimestamp 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | ------- Summary: start ------- 02:28:13 INFO - PROCESS | 1958 | Number of tests: 14 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:3.08 (2.8%) stddev-sans-first:3.27 02:28:13 INFO - PROCESS | 1958 | Values: 111.0 108.0 110.0 109.0 111.0 111.0 119.0 111.0 109.0 109.0 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:143.50 stddev:16.75 (11.7%) stddev-sans-first:16.23 02:28:13 INFO - PROCESS | 1958 | Values: 154.0 119.0 142.0 153.0 116.0 138.0 115.0 150.0 145.0 114.0 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | [#2] audio-dft Cycles:10 Average:185.00 Median:186.00 stddev:1.76 (0.9%) stddev-sans-first:1.50 02:28:13 INFO - PROCESS | 1958 | Values: 182.0 185.0 183.0 186.0 186.0 186.0 184.0 184.0 186.0 188.0 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | [#3] audio-fft Cycles:10 Average:73.80 Median:57.50 stddev:24.07 (41.9%) stddev-sans-first:25.49 02:28:13 INFO - PROCESS | 1958 | Values: 70.0 79.0 74.0 115.0 55.0 57.0 57.0 58.0 118.0 55.0 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:79.00 stddev:20.39 (25.8%) stddev-sans-first:21.60 02:28:13 INFO - PROCESS | 1958 | Values: 92.0 91.0 131.0 79.0 77.0 87.0 121.0 76.0 79.0 117.0 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:86.00 stddev:1.85 (2.2%) stddev-sans-first:1.92 02:28:13 INFO - PROCESS | 1958 | Values: 86.0 83.0 87.0 84.0 87.0 83.0 87.0 83.0 86.0 83.0 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | [#6] imaging-darkroom Cycles:10 Average:104.70 Median:92.00 stddev:23.50 (25.5%) stddev-sans-first:24.47 02:28:13 INFO - PROCESS | 1958 | Values: 92.0 93.0 106.0 148.0 149.0 92.0 92.0 92.0 92.0 91.0 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | [#7] imaging-desaturate Cycles:10 Average:89.00 Median:86.50 stddev:9.75 (11.3%) stddev-sans-first:10.32 02:28:13 INFO - PROCESS | 1958 | Values: 87.0 84.0 85.0 87.0 86.0 84.0 91.0 116.0 83.0 87.0 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:58.00 stddev:5.12 (8.8%) stddev-sans-first:5.43 02:28:13 INFO - PROCESS | 1958 | Values: 57.0 58.0 58.0 58.0 57.0 56.0 59.0 69.0 50.0 51.0 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:71.50 stddev:12.84 (18.0%) stddev-sans-first:13.06 02:28:13 INFO - PROCESS | 1958 | Values: 64.0 61.0 68.0 75.0 74.0 69.0 69.0 69.0 97.0 98.0 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:1.17 (1.5%) stddev-sans-first:1.24 02:28:13 INFO - PROCESS | 1958 | Values: 81.0 80.0 81.0 80.0 80.0 80.0 79.0 80.0 82.0 83.0 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.00 stddev:8.61 (6.9%) stddev-sans-first:7.28 02:28:13 INFO - PROCESS | 1958 | Values: 138.0 124.0 129.0 115.0 127.0 105.0 124.0 124.0 123.0 123.0 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:129.70 Median:132.00 stddev:4.52 (3.4%) stddev-sans-first:4.64 02:28:13 INFO - PROCESS | 1958 | Values: 133.0 122.0 134.0 132.0 131.0 121.0 132.0 132.0 129.0 131.0 02:28:13 INFO - PROCESS | 1958 | 02:28:13 INFO - PROCESS | 1958 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:67.00 stddev:1.29 (1.9%) stddev-sans-first:1.17 02:28:13 INFO - PROCESS | 1958 | Values: 64.0 65.0 66.0 65.0 67.0 67.0 67.0 67.0 64.0 67.0 02:28:13 INFO - PROCESS | 1958 | -------- Summary: end -------- 02:28:13 INFO - PROCESS | 1958 | 02:28:14 INFO - TEST-INFO | 1958: exit 0 02:28:14 INFO - TEST-OK | kraken | took 56182ms 02:28:14 INFO - SUITE-END | took 1168s 02:28:14 INFO - Completed test suite (00:19:29) 02:28:14 INFO - javascript benchmark 02:28:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3397.048826328628, 3496.5629296337975, 3512.0, 3517.120719820045, 3539.734519911006, 5728.0, 5739.684317362543, 5743.253377060987, 5766.308043034836, 5814.883702325951, 5817.912731309023, 5853.356130825617, 5856.180134781123, 5866.589338746289, 5870.47165755083, 5095.286659867622, 5169.30214421054, 5181.844544663666, 5200.245964335169, 5284.550813180865, 5306.681599104047, 5309.787608495655, 5312.229726689628, 5317.734113294339, 5318.30861987943, 5147.330846989905, 5191.299174611436, 5195.298634684326, 5229.372475302969, 5311.336082989626, 5252.422233554306, 5317.574594032488, 5325.147976323769, 5334.146536554172, 5353.892922141536, 5042.697438153723, 5226.764795584208, 5238.266642670029, 5238.554722848562, 5240.34495688039, 5635.971820140873, 5718.1136923776885, 5735.627184233053, 5739.110437882135, 5747.3677895431465, 6123.9387606124255, 6204.906926396107, 6211.0372892201785, 6222.408871157233, 6231.626102433823, 6146.416090471398, 6161.4146656067605, 6223.844403889939, 6237.438630523229, 6291.937080629181, 5948.464638182541, 5964.731587078549, 5967.0, 5974.850628734316, 5976.641401515923, 6177.598456100339, 6313.715882785285, 6318.052292156213, 6319.747210111636, 6342.397472240222, 6124.989376752875, 6157.599756015845, 6182.103594978703, 6192.969035154795, 6268.749250030039, 6279.403456671609, 6279.403456671609, 6286.748530058747, 6293.339199383999, 6299.149614802035, 6230.688465576703, 6276.215473065867, 6281.528885333618, 6292.968535157386, 6298.622082675054, 5212.452692467236, 6174.25908890936, 6226.439620434092, 6249.437550620466, 6286.591371560834, 4915.016996600694, 4918.803247870117, 4948.851534453972, 4952.0, 4954.752262386866, 4433.645308375322, 4474.993126546501, 4521.0, 4539.546045395434, 4542.295944128599, 5766.04860198071, 5818.650880947157, 5824.097264923944, 5830.941690583125, 5872.383399742966, 6179.752809887555, 6257.030160325156, 6260.530460215411, 6266.122742816009, 6274.309825919146, 5725.141228815711, 5815.88368232633, 5823.068309070613, 5838.7080645967535, 5847.152162936351, 5411.485908838654, 5425.891482170335, 5428.9185662215095, 5430.56555475561, 5434.184872269112, 6242.812715618538, 6337.7781777637565, 6377.17096777416, 6404.871902561923, 6417.614943103429, 6207.224096987877, 6231.0, 6263.749450021948, 6268.780592679417, 6272.18461599989, 6364.268109167319, 6373.139626150596, 6377.681115944277, 6385.489160867212, 6400.679966001774, 6133.049377346519, 6139.706800529493, 6151.138840562236, 6277.309495955533, 6281.96859015702, 6232.127502149793, 6240.0, 6240.625562466266, 6255.40573645503, 6257.56197066201, 6200.627962322275, 6203.534734894811, 6206.813795586139, 6215.9378406215355, 6225.968870155621, 5938.851528711817, 6142.232220972379, 6205.968970155301, 6221.688915554295, 6238.968805155945, 6022.316298459343, 6049.971504844275, 6059.3637668045985, 6060.363661815446, 6102.1762062122825, 5060.443351231435, 6172.475339596184, 6178.938210617836, 6186.319504854552, 6193.721282542387, 5982.312034116132, 6011.909821352596, 6115.449609535163, 6116.445413412548, 6120.08198770188], "unit": "score", "name": "dojo.html", "value": 5752.53401090667}, {"lowerIsBetter": false, "replicates": [471.99056018879645, 579.7130370577316, 585.096026638843, 670.8322919270182, 671.2951401028921, 31982.36035279296, 40044.1991160177, 40509.59490405095, 40525.39211911824, 40551.0, 43679.78160109203, 44230.115397692105, 44345.1130977381, 44347.556524434745, 44414.0, 9577.281703872202, 9820.459874706889, 9821.116099551038, 9828.164606008462, 9847.65533206338, 9618.038196180396, 9768.218542516617, 9776.413415195075, 9781.0, 9781.559829807677, 9693.273004524688, 9865.950670246639, 9869.703908882744, 9875.753106172331, 9921.35511191774, 9797.412155270707, 9846.458444785534, 9849.753756156082, 9849.90150098497, 9853.605855765796, 9682.080202380834, 9819.754506137333, 9827.90172098277, 9829.164521015722, 9837.508124593813, 42132.78933605343, 42613.57386426127, 42637.36043959343, 42690.15788579043, 42712.78643606762, 3281.868725250987, 3451.7238620910266, 3453.3783918894587, 3476.7566270361085, 3919.176972835708, 29047.41905161906, 29270.70729292701, 29490.852545737347, 30082.398352032837, 30152.698473015207, 2781.624480695121, 2815.6339675842214, 2839.0, 2849.202223377458, 2860.013295413079, 370198.0, 372468.0, 372933.0, 373027.0, 373350.0, 46943.0, 47566.76216618964, 66349.66825165843, 66709.33290667032, 67087.0, 46706.299405508944, 46777.766111169905, 46979.76510117428, 47041.0, 47143.76428117837, 16764.497065088068, 16859.915700421418, 16879.40922067722, 16907.661846762996, 16931.492055238115, 13232.0, 13281.867181328256, 13284.667883302995, 13310.401031953585, 13313.134646247963, 13007.804882926574, 15112.0, 15382.3077961492, 15395.230238488031, 15401.922990385201, 6499.2200935887995, 6672.232693240242, 6684.699188536528, 6719.462443004548, 6745.7976260711275, 974.5370948799406, 981.3032746749888, 992.7369247149511, 1085.9574808184075, 1117.407773879845, 30224.395512089635, 30487.390252195277, 30657.846710766302, 30823.524733577276, 30937.0, 1012.8480727890875, 1064.7604289034905, 1103.773726386089, 1120.7982563138714, 1130.2596799096605, 13203.735925281633, 15362.0, 15522.0, 15586.454474093352, 15632.039551063615, 550980.0, 553691.0, 558380.0, 559973.0, 560828.0, 60940.781184376065, 61501.69249153726, 61533.0, 61804.0, 61810.38189618136, 1490.1059364381501, 1513.9015963962306, 1526.213999790109, 1554.518099389193, 1557.914314712679, 28735.0, 29441.96953106631, 30007.699923001364, 30040.0, 30753.231169220948, 48213.55359339225, 48780.0, 49052.0, 49059.77350566264, 49243.26135108048, 374860.0, 377169.0, 377257.0, 377744.0, 378286.0, 25021.249362519153, 33821.492677610346, 34916.47625285572, 34981.82509087438, 35050.12374690653, 41629.375559366024, 42546.0, 42576.5742342585, 42889.35665964951, 44142.558574413844, 28114.29714257078, 34126.146846329044, 36540.53837846563, 37826.43260351152, 38193.80903095467, 36751.0, 36903.63096369002, 37220.62779372172, 37799.43300850435, 38218.0, 36687.0, 37028.25943481169, 37153.07117322089, 37500.0, 37804.62195378011, 31890.0, 33027.504587430725, 33216.0, 33239.0, 33422.665773341956, 24806.25581232566, 25141.24576262715, 25168.0, 25571.872140639178, 25689.87155064213], "unit": "score", "name": "ext.html", "value": 19386.162849407345}, {"lowerIsBetter": false, "replicates": [295.5360084667073, 372.184915036071, 372.23691432563254, 379.63554987212274, 384.34469229962883, 20253.291134810286, 20826.89586552067, 20840.583188336223, 21265.468363290885, 21267.57464850702, 12090.790920907904, 12495.000399968003, 12499.687507812308, 12499.875001249984, 12503.06227032974, 5103.591712662978, 5256.8160114395905, 5921.437463440966, 5938.346781853993, 5941.227640406741, 5781.132830075501, 5818.854528636797, 5823.563232757539, 5840.532757379399, 5844.1818145459665, 5542.889142217154, 5786.942130578704, 5794.68129252891, 5820.679862607555, 5862.736176872029, 5774.769009239625, 5804.448577385163, 5812.709364531777, 5819.592628516006, 5822.0684690449325, 5017.54842064216, 5071.366079240095, 5112.769925353368, 5116.462771408986, 5152.587792976553, 13890.861091389159, 14029.85970140306, 14217.289135543182, 15146.772798408032, 26104.477910441874, 2126.9787302126933, 2222.288867562381, 2251.4934139818574, 2653.761161495475, 2897.1018984114994, 9377.296702747253, 10388.532516036796, 10495.370277783357, 10522.473876306154, 10539.314944528582, 1703.7699910512047, 1803.251650565014, 1890.4990177602947, 1893.2994791927076, 1978.485593745622, 105029.94970050278, 109440.0, 110594.44702776434, 111576.4421177897, 113829.29256061166, 9802.122396872262, 10319.690409287734, 11816.88183118175, 11890.46492907804, 12068.577599783965, 14448.205348705711, 14469.493567725289, 14476.203808790407, 14537.563873083824, 14560.563183104523, 7482.289182527651, 9030.683926062688, 9099.454032758056, 9102.271818254523, 9181.954090229507, 6692.498062645321, 7545.773626791205, 8969.058248883774, 9318.0, 9500.857487137699, 4578.221702310615, 4667.416572928384, 4669.159551280802, 4675.95324046762, 4708.623310135181, 1926.730257763914, 1966.5575245569632, 1976.960460790776, 1977.3474753331366, 1986.9304574340117, 872.7294538693026, 937.4937533731709, 963.802420503795, 1011.9797604047877, 1018.7504061504978, 19166.616667666567, 20908.16367345289, 20924.790752092587, 20951.580968380546, 20983.95080246012, 967.3180407812475, 1010.3887148275188, 1032.3444612670858, 1032.9690109296732, 1061.2200032975757, 9410.01194874542, 10711.678649640524, 10913.39976301311, 11153.051990580729, 11156.944215279034, 563902.0, 602132.0, 679760.6011970007, 698942.0, 699994.0, 105346.0, 109953.45023274992, 113359.0, 129776.0, 135068.0, 1014.7919676466307, 1042.296449896317, 1058.2539309786582, 1059.6132411669685, 1060.9628662996759, 17646.823531765032, 17680.64638707193, 17754.37859674905, 18185.45443636693, 18343.724844127617, 40887.77336679905, 45154.09691806211, 47128.29307560321, 48257.55227343185, 49641.0, 70033.0, 70840.0, 71057.64471177818, 71881.6405917967, 72018.63990680013, 7864.410169237216, 7987.64055617487, 8022.358211343195, 8066.0, 8384.916150838413, 13115.0, 13381.464741410235, 13478.79781803254, 13785.103968242032, 13791.448342066205, 9902.0, 11594.826077609012, 11706.297622142698, 11732.589359372381, 11767.999720023894, 11656.825147622962, 11680.94159529197, 11731.296122232694, 11760.176787625127, 11919.642410727693, 11930.105242106703, 11940.582079627171, 11986.101042422028, 12104.636860894187, 12124.454399552218, 8220.3834712398, 8223.712170074019, 8432.789180270542, 8511.702090426805, 8549.230569248797, 8885.644574217218, 9991.100800927952, 11674.649760507198, 11692.94153529261, 11885.702857428634], "unit": "score", "name": "jquery.html", "value": 9320.850129688582}, {"lowerIsBetter": false, "replicates": [1503.0305452982834, 1629.1039928039577, 1659.0709202846406, 1976.347805224276, 2047.692846073089, 7702.96148519258, 8294.419390642657, 8906.77733056674, 9101.0, 9145.496997665126, 8674.653013879437, 8933.687320943769, 8935.195832375084, 8967.551622418885, 8968.596413161407, 2243.9663405048855, 2404.8076153907646, 2437.8659173745436, 2541.2122242104915, 2571.7556832101013, 2468.3705655057934, 2479.466914613358, 2483.056438553347, 2483.950320993579, 2486.0552989863827, 2352.847064940782, 2524.4572416930355, 2542.9745702542923, 2544.2875994721417, 2544.5038217547585, 2522.318973877052, 2564.7178810330847, 2565.756253155947, 2566.47387285606, 2570.447353818919, 2530.0, 2561.756633119869, 2564.217913536371, 2568.895374988773, 2569.961450578243, 8976.281897448189, 9037.322200834898, 9040.728778136667, 9044.10073884485, 9061.773455663595, 5549.056660367747, 5710.543156547466, 5710.685912274823, 5716.42835716425, 5732.168835518868, 3633.3096711624707, 3688.0595448160816, 3777.0557360659836, 3783.3379158647404, 3797.7721336719887, 1062.8990245926625, 1070.4166229404993, 1079.983800242997, 1095.3044816541474, 1116.7040734205361, 12371.0, 12388.256704597752, 12406.379681016004, 12408.069394795337, 12434.316112613802, 5010.949890501121, 5018.146915024455, 5086.949130508721, 5092.210707340369, 5107.9489205107475, 9544.045595440539, 9864.802703946025, 10490.423026733602, 10504.842427363596, 10506.474676266156, 4871.634627402959, 5679.204911312337, 5679.5172410345585, 5680.4319568042865, 5691.516221121168, 4529.479109902338, 4716.716996980193, 4970.453250142481, 5044.0, 5074.340335756328, 4063.8463098435286, 4108.979455102765, 4143.3370660694145, 4175.83296668136, 4178.874633760931, 1337.8260826092546, 1355.5594431809504, 1363.6659018540322, 1376.2430663135235, 1379.661982814217, 1040.458961340099, 1041.432419331451, 1139.5214010115772, 1156.9537218511334, 1229.8155276708387, 8411.158884111539, 8433.451825631315, 8437.746867593982, 8506.149385061444, 8509.234168924826, 530.4456842599493, 535.4484880573016, 542.3275138827825, 542.7421974562052, 544.1076634319719, 6230.813075607648, 6295.5907865988565, 6306.0225665022, 6318.810435686937, 6319.0, 10331.380117192992, 10947.397893115955, 10958.0, 10973.957474039953, 10975.890241097646, 10346.068853803194, 10724.78550428987, 10741.51663175159, 10804.973527514874, 10825.512851921683, 8177.795555111051, 8316.043654979634, 8371.372147088992, 8376.455530390505, 8376.539290338967, 7940.761777146695, 7945.6027198640995, 7954.761357159295, 8215.58922053883, 8330.833383332421, 9620.663276785279, 9622.37454565451, 9665.71002869915, 9701.951490242503, 9769.902300977183, 9872.901270987199, 9998.95011023832, 10015.949920250352, 10091.899081009096, 10121.746956326151, 6948.6525673715105, 7039.472039596948, 7622.31399174077, 7706.460547761827, 7864.252895974873, 8448.746537603882, 8480.491170529542, 8520.786980325542, 8527.488350698977, 8537.82924341522, 7392.26077392278, 7554.0, 7622.5426474411715, 7666.9616651916385, 7695.692172313269, 7436.888446673196, 7483.32650061497, 7501.962490187514, 7504.986826778315, 7601.049868766404, 8051.1546287641295, 8077.03075630928, 8086.231807978233, 8101.959490202511, 8110.188981101843, 7249.963750181215, 7279.490435669452, 7359.668814903235, 7422.25777422275, 7429.665665045194, 7426.777196684108, 7447.106347238366, 7480.925190748023, 7487.588182650006, 7494.17564067963], "unit": "score", "name": "mootools.html", "value": 4955.173540082681}, {"lowerIsBetter": false, "replicates": [332.7339473304078, 337.58477073199964, 342.175357388693, 344.107042225425, 347.7131366622537, 6491.156149700532, 6494.740210391585, 6543.280239173693, 6547.279799222094, 6555.3772391622715, 6422.454091402225, 6460.741570337181, 6477.967610161954, 6479.870402591957, 6480.287168411471, 4588.242939914927, 4640.767961601923, 4724.503927087658, 4781.760911954406, 4851.393575803016, 4298.743159841093, 4425.424694789689, 4766.594839438634, 4830.154722923475, 4848.17581011229, 4772.451168115676, 4780.880477988061, 4781.115493633672, 4801.951980480186, 4803.18345881201, 4526.524714904937, 4613.5847773700525, 4776.426828780569, 4807.230843065127, 4811.137373262903, 3439.8968030959113, 4143.4199212110325, 4150.0, 4152.896177595554, 4165.000399904032, 6161.568690191689, 6165.876682466325, 6172.7530898764, 6183.690815459209, 6186.474149697281, 5650.858728531778, 5656.575756818214, 5662.773489060432, 5674.801381951653, 5683.2895888014, 5536.695481748502, 6898.344657257552, 6904.378605925491, 6912.274211207801, 6917.169939607279, 4330.437043184366, 4476.261416866213, 4477.888052798674, 4480.283154695266, 4483.618892394118, 6970.825729356756, 7151.249118842498, 7184.137903451567, 7214.63926803663, 7245.963770181115, 4605.746683932349, 4610.95389046112, 4623.283391074388, 4626.259798432302, 4634.629229661687, 4662.114198302312, 4669.906601868011, 4679.766011699401, 4681.789319480631, 4686.625069994392, 5507.834764957058, 5512.641678290898, 5524.281843360418, 5526.226328314039, 5532.474414930575, 5651.858703532363, 6652.634105124264, 6888.138982627172, 6954.756583519654, 6962.825929351807, 1610.5892997285616, 1616.7009103315688, 1627.0725686358899, 1629.8940568862986, 1630.7879975603096, 990.7225976726528, 1020.4846552491093, 1046.4035499765214, 1049.3231865446896, 1070.5182667799365, 4781.545753153445, 5826.436367998067, 6014.947384207746, 6400.519961002943, 6422.068800023971, 7211.819704507429, 7213.062301900824, 7218.0, 7222.422206223489, 7245.985562021321, 6414.679266036679, 6428.903566446507, 6434.195725534309, 6437.839054023687, 6459.935400646027, 3740.663340299386, 3790.5451345838123, 3791.374423220138, 3792.60177681345, 3793.7534060285993, 7199.06412166415, 7469.813254668568, 7482.5884576347735, 7506.28690274423, 7514.586697731677, 7362.815929601803, 7371.88942165868, 7431.665575049135, 7444.367228785505, 7464.738734144387, 7463.179050304462, 7468.5145465544565, 7474.850502990019, 7492.887606685795, 7493.66278517468, 6947.096877405905, 7194.784156475314, 7206.991021257133, 7215.530990485601, 7217.530860494051, 7086.39765619928, 7118.039064726196, 7121.359077683033, 7121.4302855770375, 7130.108736407949, 7398.630068496446, 7446.553206807609, 7447.106347238366, 7472.887906681295, 7475.0, 4628.39830821991, 4644.187267228289, 4652.488226295037, 4655.673133157034, 4660.13787449323, 7140.250273721184, 7140.321669441395, 7152.642367881481, 7160.964195178991, 7162.355388015104, 6625.933740662532, 6946.131733533309, 6959.965200173967, 6963.825904352431, 6969.7909062728195, 6888.965555172192, 6919.861602768017, 6946.305369463013, 6954.79135625932, 6968.163820341591, 6755.7973260802255, 6764.323567643196, 6787.355201255873, 6787.762428314985, 6799.694013769491, 6078.483328917092, 6102.603330783485, 6215.906761398673, 6269.279032911274, 6512.762575110713, 6019.458248757458, 6538.019297105472, 6592.8351791205605, 6756.358145976124, 6800.285969973082], "unit": "score", "name": "prototype.html", "value": 5043.450909554757}, {"lowerIsBetter": false, "replicates": [608.8569186241233, 711.0649495912877, 785.5169071021322, 792.1125811072718, 807.2331285278983, 15428.382864685413, 15521.068735875855, 15591.922040389782, 15593.766093508606, 15618.531444056682, 14370.568882933503, 14413.063150895185, 14466.710665786677, 14473.78289325661, 14483.058601190914, 794.3684770607352, 804.8108694456798, 942.6936245720168, 956.1585804492038, 990.5146478225689, 965.2085290062151, 974.4835237324229, 977.7506735782365, 979.6424305128612, 980.446047982891, 1051.5215576912524, 1056.0759335581367, 1063.0538820449767, 1063.2291588598243, 1064.276292121357, 828.693383448125, 999.8400255959048, 1037.667946257198, 1039.5893622019335, 1040.8542804007445, 773.5822655765879, 775.6315750018696, 776.8679324514846, 776.9922300776976, 778.4823092643385, 15401.460948866848, 15407.306671199824, 15457.690846183013, 15471.767923481157, 15472.535823925187, 12842.293673847935, 13110.344482775918, 13160.341982900816, 13171.802422963663, 13699.287589051368, 10174.236932230038, 10286.7428314292, 10351.741206469824, 10456.68629941103, 10972.670819875417, 4077.673786097105, 4147.232761939021, 4170.687198460128, 4191.790410479463, 4270.658347332206, 77630.6118469404, 78637.0, 79062.0, 79502.60248698719, 79992.60003699944, 9633.181179599813, 9766.121049105472, 9795.657151999789, 9829.115379615869, 10497.0, 19040.61918761617, 24238.15166469165, 24521.340945220352, 24570.0, 24572.754272457405, 7737.381009519225, 7876.921230787733, 7886.408519360956, 8007.239312265326, 8278.586070696441, 3377.5778027746533, 3931.4495970564144, 3937.1731936293127, 3979.8408063677707, 4055.351143817034, 3701.5373078365205, 3750.6061863503937, 3754.6433088856515, 3756.4365345197893, 3769.076576238784, 565.6832173982501, 608.2974164839617, 618.0482057631198, 679.5107522583731, 693.5942473652868, 597.1192491075628, 600.7596961215548, 604.1813342920368, 613.9508839292846, 624.4161708802285, 8167.591620418955, 8241.423100383035, 8389.161083891684, 8413.158684131538, 8654.783630409163, 599.241958921964, 600.7056542294332, 602.9427204415573, 624.1231070346171, 626.1640709652573, 3905.1213476968023, 3965.325894597925, 3984.8406063757707, 4007.599240075969, 4114.588541145861, 96029.5595566067, 98970.17453567781, 99515.0, 100583.0, 100787.0, 82652.17347826445, 87873.0, 88161.55919220363, 89628.5518572416, 89919.55040224757, 74649.0, 76720.84918726224, 77265.6136719324, 78804.0, 79034.20965790383, 7976.441649084509, 8058.113607503287, 8061.87907181381, 8146.9185308148535, 8223.629936652746, 53344.4665553355, 53406.73296633492, 53483.19775203453, 53976.0, 54003.72998135141, 68881.0, 69221.30778692149, 69223.65388173026, 71474.64262678653, 71612.64193678998, 11304.43477826089, 11435.59975400857, 11460.541578336773, 11701.94682478581, 11967.982721468772, 12107.878921210675, 12278.017758579113, 12284.938575307066, 12566.937165314115, 12657.367131643565, 11854.051675866083, 12010.459529321026, 12082.879171208528, 12196.146269761386, 12251.38743062861, 9375.85936210971, 11790.528378864748, 11848.229865058744, 11866.347350895783, 12679.55621553278, 10611.31026483276, 11175.55297788112, 11381.772364552828, 11467.025302849017, 11572.24780389272, 9956.651517196864, 9968.202543796624, 10092.444915529717, 10146.49267536635, 10522.473876306307, 10000.749981250527, 10004.499775011365, 10009.649662262078, 10015.863355648475, 10054.19566434669], "unit": "score", "name": "yui.html", "value": 7222.3466413726765}], "name": "dromaeo_css", "value": 7566.312230000743}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 109.0, 111.0, 111.0, 119.0, 111.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [154.0, 119.0, 142.0, 153.0, 116.0, 138.0, 115.0, 150.0, 145.0, 114.0], "unit": "score", "name": "audio-beat-detection", "value": 134.6}, {"lowerIsBetter": true, "replicates": [182.0, 185.0, 183.0, 186.0, 186.0, 186.0, 184.0, 184.0, 186.0, 188.0], "unit": "score", "name": "audio-dft", "value": 185.0}, {"lowerIsBetter": true, "replicates": [70.0, 79.0, 74.0, 115.0, 55.0, 57.0, 57.0, 58.0, 118.0, 55.0], "unit": "score", "name": "audio-fft", "value": 73.8}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 131.0, 79.0, 77.0, 87.0, 121.0, 76.0, 79.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 95.0}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 87.0, 84.0, 87.0, 83.0, 87.0, 83.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.9}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 106.0, 148.0, 149.0, 92.0, 92.0, 92.0, 92.0, 91.0], "unit": "score", "name": "imaging-darkroom", "value": 104.7}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 85.0, 87.0, 86.0, 84.0, 91.0, 116.0, 83.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 89.0}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 58.0, 58.0, 57.0, 56.0, 59.0, 69.0, 50.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [64.0, 61.0, 68.0, 75.0, 74.0, 69.0, 69.0, 69.0, 97.0, 98.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 74.4}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 81.0, 80.0, 80.0, 80.0, 79.0, 80.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.6}, {"lowerIsBetter": true, "replicates": [138.0, 124.0, 129.0, 115.0, 127.0, 105.0, 124.0, 124.0, 123.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [133.0, 122.0, 134.0, 132.0, 131.0, 121.0, 132.0, 132.0, 129.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 129.7}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 66.0, 65.0, 67.0, 67.0, 67.0, 67.0, 64.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1408.9}]} 02:28:14 INFO - Return code: 0 02:28:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:28:14 INFO - # TBPL SUCCESS # 02:28:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:28:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:28:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:28:14 INFO - 2016-03-12 02:28:14.980 screenresolution[1962:15226] starting screenresolution argv=screenresolution get 02:28:14 INFO - 2016-03-12 02:28:14.983 screenresolution[1962:15226] Display 0: 1600x1200x32@60 02:28:14 INFO - 2016-03-12 02:28:14.989 screenresolution[1963:15229] starting screenresolution argv=screenresolution list 02:28:14 INFO - Available Modes on Display 0 02:28:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:28:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:28:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:28:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:28:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:28:15 INFO - Intel Iris: 02:28:15 INFO - Chipset Model: Intel Iris 02:28:15 INFO - Type: GPU 02:28:15 INFO - Bus: Built-In 02:28:15 INFO - VRAM (Dynamic, Max): 1536 MB 02:28:15 INFO - Vendor: Intel (0x8086) 02:28:15 INFO - Device ID: 0x0a2e 02:28:15 INFO - Revision ID: 0x0009 02:28:15 INFO - Displays: 02:28:15 INFO - Display: 02:28:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:28:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:28:15 INFO - Display Serial Number: 1600x1200 60 02:28:15 INFO - Main Display: Yes 02:28:15 INFO - Mirror: Off 02:28:15 INFO - Online: Yes 02:28:15 INFO - Rotation: Supported 02:28:15 INFO - Return code: 0 02:28:15 INFO - Running post-action listener: _resource_record_post_action 02:28:15 INFO - Running post-run listener: _resource_record_post_run 02:28:16 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 733184; Write bytes: 664449536; Read time: 9; Write time: 2610 02:28:16 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 361011712; Write bytes: 363350016; Read time: 28250; Write time: 795 02:28:16 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 733184; Write bytes: 299567616; Read time: 9; Write time: 1810 02:28:16 INFO - Running post-run listener: _upload_blobber_files 02:28:16 INFO - Blob upload gear active. 02:28:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:28:16 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 02:28:16 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:28:16 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:28:16 INFO - (blobuploader) - INFO - Open directory for files ... 02:28:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:28:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:28:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:17 INFO - (blobuploader) - INFO - Done attempting. 02:28:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:28:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:28:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:18 INFO - (blobuploader) - INFO - Done attempting. 02:28:18 INFO - (blobuploader) - INFO - Iteration through files over. 02:28:18 INFO - Return code: 0 02:28:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:28:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:28:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a18017eec50ef1d7fd88aae3a39640d96864062fc5e9740ce2eb9f04b2763a86c3b4a0b75e3e4f16a28983640cd32acddd9f0107aa8668d7a691933b249f4117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aeaedf78c09120b3a1ccf6c5e6385ffa1859c60211038489b6316d4073e9b1b932111e70f81d5aa969da52f41af3abfe0403bead2ac67457b46b7b3416e646c0"} 02:28:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:28:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:28:18 INFO - Contents: 02:28:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a18017eec50ef1d7fd88aae3a39640d96864062fc5e9740ce2eb9f04b2763a86c3b4a0b75e3e4f16a28983640cd32acddd9f0107aa8668d7a691933b249f4117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aeaedf78c09120b3a1ccf6c5e6385ffa1859c60211038489b6316d4073e9b1b932111e70f81d5aa969da52f41af3abfe0403bead2ac67457b46b7b3416e646c0"} 02:28:18 INFO - Running post-run listener: copy_logs_to_upload_dir 02:28:18 INFO - Copying logs to upload dir... 02:28:18 INFO - mkdir: /builds/slave/test/build/upload/logs 02:28:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.810900 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-12 02:28:18.375977) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 02:28:18.379401) ========= 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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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/Mozilla-Aurora/sha512/a18017eec50ef1d7fd88aae3a39640d96864062fc5e9740ce2eb9f04b2763a86c3b4a0b75e3e4f16a28983640cd32acddd9f0107aa8668d7a691933b249f4117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aeaedf78c09120b3a1ccf6c5e6385ffa1859c60211038489b6316d4073e9b1b932111e70f81d5aa969da52f41af3abfe0403bead2ac67457b46b7b3416e646c0"} build_url:https://queue.taskcluster.net/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011102 build_url: 'https://queue.taskcluster.net/v1/task/D9awM7WURJG5nrU31RGNqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a18017eec50ef1d7fd88aae3a39640d96864062fc5e9740ce2eb9f04b2763a86c3b4a0b75e3e4f16a28983640cd32acddd9f0107aa8668d7a691933b249f4117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aeaedf78c09120b3a1ccf6c5e6385ffa1859c60211038489b6316d4073e9b1b932111e70f81d5aa969da52f41af3abfe0403bead2ac67457b46b7b3416e646c0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 02:28:18.406797) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 02:28:18.407119) ========= 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.2hBVv1qKhv/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.M6QeCNKIKk/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.005085 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 02:28:18.456008) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 02:28:18.456439) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 02:28:18.456811) ========= ========= Total master_lag: 0.65 =========