builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0159 starttime: 1458725925.78 results: success (0) buildid: 20160323004040 builduid: ed8f6da712084d9c92511b35a377ce4e revision: 5c247ef4c02899a3ab3cf4626ae2eaf40868b493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:45.783020) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:45.783452) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:45.783745) ========= 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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.005482 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:45.811899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:45.812932) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:45.831469) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:45.831744) ========= 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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.005642 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:45.883834) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:45.884369) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:45.884950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:45.885561) ========= 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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-23 02:38:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 163M=0s 2016-03-23 02:38:45 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107400 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:46.009127) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:46.009447) ========= 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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.025862 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:46.057460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:46.057804) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5c247ef4c02899a3ab3cf4626ae2eaf40868b493 --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 5c247ef4c02899a3ab3cf4626ae2eaf40868b493 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v75AYWRJzm/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.qo5Bb8FBCH/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-23 02:38:46,139 truncating revision to first 12 chars 2016-03-23 02:38:46,139 Setting DEBUG logging. 2016-03-23 02:38:46,140 attempt 1/10 2016-03-23 02:38:46,140 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5c247ef4c028?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 02:38:46,738 unpacking tar archive at: mozilla-aurora-5c247ef4c028/testing/mozharness/ program finished with exit code 0 elapsedTime=0.851374 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:46.929451) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:46.930307) ========= echo 5c247ef4c02899a3ab3cf4626ae2eaf40868b493 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5c247ef4c02899a3ab3cf4626ae2eaf40868b493'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v75AYWRJzm/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.qo5Bb8FBCH/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 5c247ef4c02899a3ab3cf4626ae2eaf40868b493 program finished with exit code 0 elapsedTime=0.005378 script_repo_revision: '5c247ef4c02899a3ab3cf4626ae2eaf40868b493' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:46.981986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:46.982269) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 02:38:46.995965) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 17 secs) (at 2016-03-23 02:38:46.996322) ========= /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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:38:47 INFO - MultiFileLogger online at 20160323 02:38:47 in /builds/slave/test 02:38:47 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:38:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:38:47 INFO - {'append_to_log': False, 02:38:47 INFO - 'base_work_dir': '/builds/slave/test', 02:38:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:38:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:38:47 INFO - 'branch': 'Mozilla-Aurora', 02:38:47 INFO - 'buildbot_json_path': 'buildprops.json', 02:38:47 INFO - 'config_files': ('talos/mac_config.py',), 02:38:47 INFO - 'default_actions': ('clobber', 02:38:47 INFO - 'read-buildbot-config', 02:38:47 INFO - 'download-and-extract', 02:38:47 INFO - 'populate-webroot', 02:38:47 INFO - 'create-virtualenv', 02:38:47 INFO - 'install', 02:38:47 INFO - 'run-tests'), 02:38:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:38:47 INFO - 'download_minidump_stackwalk': True, 02:38:47 INFO - 'download_symbols': 'ondemand', 02:38:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:38:47 INFO - 'tooltool.py': '/tools/tooltool.py', 02:38:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:38:47 INFO - '/tools/misc-python/virtualenv.py')}, 02:38:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:38:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:38:47 INFO - 'installer_path': 'installer.exe', 02:38:47 INFO - 'log_level': 'info', 02:38:47 INFO - 'log_name': 'talos', 02:38:47 INFO - 'log_to_console': True, 02:38:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:38:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:38:47 INFO - 'opt_config_files': (), 02:38:47 INFO - 'pip_index': False, 02:38:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:38:47 INFO - 'cmd': ('bash', 02:38:47 INFO - '-c', 02:38:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:38:47 INFO - 'enabled': True, 02:38:47 INFO - 'halt_on_failure': False, 02:38:47 INFO - 'name': 'check_screen_resolution'},), 02:38:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:38:47 INFO - 'cmd': ('bash', 02:38:47 INFO - '-c', 02:38:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:38:47 INFO - 'enabled': True, 02:38:47 INFO - 'halt_on_failure': False, 02:38:47 INFO - 'name': 'check_screen_resolution'},), 02:38:47 INFO - 'run_cmd_checks_enabled': True, 02:38:47 INFO - 'sps_profile': False, 02:38:47 INFO - 'sps_profile_interval': 0, 02:38:47 INFO - 'suite': 'dromaeojs', 02:38:47 INFO - 'system_bits': '32', 02:38:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:38:47 INFO - 'title': 't-yosemite-r7-0159', 02:38:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:38:47 INFO - 'use_talos_json': True, 02:38:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:38:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:38:47 INFO - 'work_dir': 'build'} 02:38:47 INFO - ##### 02:38:47 INFO - ##### Running clobber step. 02:38:47 INFO - ##### 02:38:47 INFO - Running pre-action listener: _resource_record_pre_action 02:38:47 INFO - Running main action method: clobber 02:38:47 INFO - rmtree: /builds/slave/test/build 02:38:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:38:49 INFO - Running post-action listener: _resource_record_post_action 02:38:49 INFO - ##### 02:38:49 INFO - ##### Running read-buildbot-config step. 02:38:49 INFO - ##### 02:38:49 INFO - Running pre-action listener: _resource_record_pre_action 02:38:49 INFO - Running main action method: read_buildbot_config 02:38:49 INFO - Using buildbot properties: 02:38:49 INFO - { 02:38:49 INFO - "project": "", 02:38:49 INFO - "product": "firefox", 02:38:49 INFO - "script_repo_revision": "production", 02:38:49 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:38:49 INFO - "repository": "", 02:38:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:38:49 INFO - "buildid": "20160323004040", 02:38:49 INFO - "stage_platform": "macosx64", 02:38:49 INFO - "basedir": "/builds/slave/test", 02:38:49 INFO - "nightly_build": "True", 02:38:49 INFO - "buildnumber": 231, 02:38:49 INFO - "slavename": "t-yosemite-r7-0159", 02:38:49 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:38:49 INFO - "platform": "yosemite_r7", 02:38:49 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:38:49 INFO - "branch": "mozilla-aurora", 02:38:49 INFO - "repo_path": "releases/mozilla-aurora", 02:38:49 INFO - "revision": "5c247ef4c02899a3ab3cf4626ae2eaf40868b493", 02:38:49 INFO - "pgo_build": "False", 02:38:49 INFO - "builduid": "ed8f6da712084d9c92511b35a377ce4e", 02:38:49 INFO - "slavebuilddir": "test" 02:38:49 INFO - } 02:38:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:38:49 INFO - Running post-action listener: _resource_record_post_action 02:38:49 INFO - ##### 02:38:49 INFO - ##### Running download-and-extract step. 02:38:49 INFO - ##### 02:38:49 INFO - Running pre-action listener: _resource_record_pre_action 02:38:49 INFO - Running main action method: download_and_extract 02:38:49 INFO - mkdir: /builds/slave/test/build/tests 02:38: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:38:49 INFO - https://queue.taskcluster.net/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:38:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:38:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:38:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/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:38:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/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:38:50 INFO - Downloaded 1277 bytes. 02:38:50 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:38:50 INFO - Using the following test package requirements: 02:38:50 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:38:50 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:38:50 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:38:50 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:38:50 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:38:50 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:38:50 INFO - u'jsshell-mac.zip'], 02:38:50 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:38:50 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:38:50 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:38:50 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:38:50 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:38:50 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:38:50 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:38:50 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:38:50 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:38:50 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:38:50 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:38:50 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:38:50 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:38:50 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:38:50 INFO - https://queue.taskcluster.net/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:38:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:38:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:38:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/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:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/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:38:51 INFO - Downloaded 17869042 bytes. 02:38:51 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:38:51 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:38:54 INFO - Return code: 0 02:38:54 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:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:54 INFO - https://queue.taskcluster.net/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:38:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:38:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:38:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/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:38:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/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:38:55 INFO - Downloaded 17869042 bytes. 02:38:55 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:38:55 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:38:59 INFO - Return code: 0 02:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:59 INFO - https://queue.taskcluster.net/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:38:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:38:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:38:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/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:38:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/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:39:00 INFO - Downloaded 10845161 bytes. 02:39:00 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:39:00 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:39:00 INFO - Return code: 0 02:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:00 INFO - https://queue.taskcluster.net/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:39:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:39:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:39:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:39:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwlF6_m0T2ikaij7HgfVTw/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:39:03 INFO - Downloaded 115149061 bytes. 02:39:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:39:03 INFO - mkdir: /builds/slave/test/properties 02:39:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:39:03 INFO - Writing to file /builds/slave/test/properties/build_url 02:39:03 INFO - Contents: 02:39:03 INFO - build_url:https://queue.taskcluster.net/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:39:05 INFO - Running post-action listener: _resource_record_post_action 02:39:05 INFO - Running post-action listener: set_extra_try_arguments 02:39:05 INFO - ##### 02:39:05 INFO - ##### Running populate-webroot step. 02:39:05 INFO - ##### 02:39:05 INFO - Running pre-action listener: _resource_record_pre_action 02:39:05 INFO - Running main action method: populate_webroot 02:39:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:39:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:39:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:39:05 INFO - '--tppagecycles', 02:39:05 INFO - '7'], 02:39:05 INFO - 'tests': ['tsvgm']}}, 02:39:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:39:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:39:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:39:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:39:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:39:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:39:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:05 INFO - 'talos_options': ['--e10s'], 02:39:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:05 INFO - 'tests': ['damp', 'tps']}, 02:39:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:05 INFO - 'talos_options': ['--e10s'], 02:39:05 INFO - 'tests': ['damp', 'tps']}, 02:39:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:39:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:39:05 INFO - 'other': {'tests': ['a11yr', 02:39:05 INFO - 'ts_paint', 02:39:05 INFO - 'tpaint', 02:39:05 INFO - 'sessionrestore', 02:39:05 INFO - 'sessionrestore_no_auto_restore', 02:39:05 INFO - 'tabpaint']}, 02:39:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:39:05 INFO - 'tests': ['a11yr', 02:39:05 INFO - 'ts_paint', 02:39:05 INFO - 'tpaint', 02:39:05 INFO - 'sessionrestore', 02:39:05 INFO - 'sessionrestore_no_auto_restore', 02:39:05 INFO - 'tabpaint']}, 02:39:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:39:05 INFO - 'tests': ['a11yr', 02:39:05 INFO - 'ts_paint', 02:39:05 INFO - 'tpaint', 02:39:05 INFO - 'sessionrestore', 02:39:05 INFO - 'sessionrestore_no_auto_restore', 02:39:05 INFO - 'tabpaint']}, 02:39:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:39:05 INFO - 'tests': ['a11yr', 02:39:05 INFO - 'ts_paint', 02:39:05 INFO - 'tpaint', 02:39:05 INFO - 'sessionrestore', 02:39:05 INFO - 'sessionrestore_no_auto_restore', 02:39:05 INFO - 'tabpaint']}, 02:39:05 INFO - 'other_l64': {'tests': ['a11yr', 02:39:05 INFO - 'ts_paint', 02:39:05 INFO - 'tpaint', 02:39:05 INFO - 'sessionrestore', 02:39:05 INFO - 'sessionrestore_no_auto_restore', 02:39:05 INFO - 'tabpaint']}, 02:39:05 INFO - 'other_nol64': {'tests': ['a11yr', 02:39:05 INFO - 'ts_paint', 02:39:05 INFO - 'tpaint', 02:39:05 INFO - 'sessionrestore', 02:39:05 INFO - 'sessionrestore_no_auto_restore', 02:39:05 INFO - 'tabpaint']}, 02:39:05 INFO - 'svgr': {'tests': ['tsvgx', 02:39:05 INFO - 'tsvgr_opacity', 02:39:05 INFO - 'tart', 02:39:05 INFO - 'tscrollx', 02:39:05 INFO - 'cart']}, 02:39:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:39:05 INFO - 'tests': ['tsvgx', 02:39:05 INFO - 'tsvgr_opacity', 02:39:05 INFO - 'tart', 02:39:05 INFO - 'tscrollx', 02:39:05 INFO - 'cart']}, 02:39:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:05 INFO - 'tests': ['tp5o']}, 02:39:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:05 INFO - 'talos_options': ['--e10s'], 02:39:05 INFO - 'tests': ['tp5o']}, 02:39:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:05 INFO - 'talos_options': ['--xperf_path', 02:39:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:05 INFO - 'tests': ['tp5n']}, 02:39:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:05 INFO - 'talos_options': ['--e10s', 02:39:05 INFO - '--xperf_path', 02:39:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:05 INFO - 'tests': ['tp5n']}}, 02:39:05 INFO - 'talos.zip': {'path': '', 02:39:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:39:05 INFO - Running post-action listener: _resource_record_post_action 02:39:05 INFO - ##### 02:39:05 INFO - ##### Running create-virtualenv step. 02:39:05 INFO - ##### 02:39:05 INFO - Running pre-action listener: _resource_record_pre_action 02:39:05 INFO - Running main action method: create_virtualenv 02:39:05 INFO - Creating virtualenv /builds/slave/test/build/venv 02:39:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:39:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:39:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:39:05 INFO - Using real prefix '/tools/python27' 02:39:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:39:05 INFO - Installing distribute.............................................................................................................................................................................................done. 02:39:08 INFO - Installing pip.................done. 02:39:08 INFO - Return code: 0 02:39:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe80d9a6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf0d30>, '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 0x10fb54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fce7b20>, '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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:39:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v75AYWRJzm/Render', 02:39:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:08 INFO - 'HOME': '/Users/cltbld', 02:39:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:08 INFO - 'LOGNAME': 'cltbld', 02:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:08 INFO - 'MOZ_NO_REMOTE': '1', 02:39:08 INFO - 'NO_EM_RESTART': '1', 02:39:08 INFO - 'PAGER': '/bin/cat', 02:39:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:08 INFO - 'PWD': '/builds/slave/test', 02:39:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:08 INFO - 'SHELL': '/bin/bash', 02:39:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qo5Bb8FBCH/Listeners', 02:39:08 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 02:39:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:08 INFO - 'USER': 'cltbld', 02:39:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:08 INFO - 'XPC_FLAGS': '0x0', 02:39:08 INFO - 'XPC_SERVICE_NAME': '0', 02:39:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:39:09 INFO - Cleaning up... 02:39:09 INFO - Return code: 0 02:39:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe80d9a6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf0d30>, '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 0x10fb54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fce7b20>, '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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:39:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:39:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:39:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v75AYWRJzm/Render', 02:39:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:09 INFO - 'HOME': '/Users/cltbld', 02:39:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:09 INFO - 'LOGNAME': 'cltbld', 02:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:09 INFO - 'MOZ_NO_REMOTE': '1', 02:39:09 INFO - 'NO_EM_RESTART': '1', 02:39:09 INFO - 'PAGER': '/bin/cat', 02:39:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:09 INFO - 'PWD': '/builds/slave/test', 02:39:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:09 INFO - 'SHELL': '/bin/bash', 02:39:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qo5Bb8FBCH/Listeners', 02:39:09 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 02:39:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:09 INFO - 'USER': 'cltbld', 02:39:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:09 INFO - 'XPC_FLAGS': '0x0', 02:39:09 INFO - 'XPC_SERVICE_NAME': '0', 02:39:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:09 INFO - Downloading/unpacking psutil>=0.7.1 02:39: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:39: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:39: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:39: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:39: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:39: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:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:39:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:12 INFO - Installing collected packages: psutil 02:39:12 INFO - Running setup.py install for psutil 02:39:12 INFO - building 'psutil._psutil_osx' extension 02:39:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:39:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:39:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:39:13 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:39:13 INFO - building 'psutil._psutil_posix' extension 02:39:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:39:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:39:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:39:13 INFO - ^ 02:39:13 INFO - 1 warning generated. 02:39:13 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:39:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:13 INFO - Successfully installed psutil 02:39:13 INFO - Cleaning up... 02:39:13 INFO - Return code: 0 02:39:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe80d9a6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf0d30>, '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 0x10fb54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fce7b20>, '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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:39:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:39:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v75AYWRJzm/Render', 02:39:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:13 INFO - 'HOME': '/Users/cltbld', 02:39:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:13 INFO - 'LOGNAME': 'cltbld', 02:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:13 INFO - 'MOZ_NO_REMOTE': '1', 02:39:13 INFO - 'NO_EM_RESTART': '1', 02:39:13 INFO - 'PAGER': '/bin/cat', 02:39:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:13 INFO - 'PWD': '/builds/slave/test', 02:39:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:13 INFO - 'SHELL': '/bin/bash', 02:39:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qo5Bb8FBCH/Listeners', 02:39:13 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 02:39:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:13 INFO - 'USER': 'cltbld', 02:39:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:13 INFO - 'XPC_FLAGS': '0x0', 02:39:13 INFO - 'XPC_SERVICE_NAME': '0', 02:39:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:39:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:39:16 INFO - Installing collected packages: mozsystemmonitor 02:39:16 INFO - Running setup.py install for mozsystemmonitor 02:39:16 INFO - Successfully installed mozsystemmonitor 02:39:16 INFO - Cleaning up... 02:39:16 INFO - Return code: 0 02:39:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe80d9a6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf0d30>, '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 0x10fb54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fce7b20>, '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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:39:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:39:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v75AYWRJzm/Render', 02:39:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:16 INFO - 'HOME': '/Users/cltbld', 02:39:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:16 INFO - 'LOGNAME': 'cltbld', 02:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:16 INFO - 'MOZ_NO_REMOTE': '1', 02:39:16 INFO - 'NO_EM_RESTART': '1', 02:39:16 INFO - 'PAGER': '/bin/cat', 02:39:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:16 INFO - 'PWD': '/builds/slave/test', 02:39:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:16 INFO - 'SHELL': '/bin/bash', 02:39:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qo5Bb8FBCH/Listeners', 02:39:16 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 02:39:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:16 INFO - 'USER': 'cltbld', 02:39:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:16 INFO - 'XPC_FLAGS': '0x0', 02:39:16 INFO - 'XPC_SERVICE_NAME': '0', 02:39:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:16 INFO - Downloading/unpacking blobuploader==1.2.4 02:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:18 INFO - Downloading blobuploader-1.2.4.tar.gz 02:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:39:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:39:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:20 INFO - Downloading docopt-0.6.1.tar.gz 02:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:39:20 INFO - Installing collected packages: blobuploader, requests, docopt 02:39:20 INFO - Running setup.py install for blobuploader 02:39:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:39:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:39:20 INFO - Running setup.py install for requests 02:39:20 INFO - Running setup.py install for docopt 02:39:21 INFO - Successfully installed blobuploader requests docopt 02:39:21 INFO - Cleaning up... 02:39:21 INFO - Return code: 0 02:39:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe80d9a6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf0d30>, '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 0x10fb54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fce7b20>, '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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:39:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:39:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v75AYWRJzm/Render', 02:39:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:21 INFO - 'HOME': '/Users/cltbld', 02:39:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:21 INFO - 'LOGNAME': 'cltbld', 02:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:21 INFO - 'MOZ_NO_REMOTE': '1', 02:39:21 INFO - 'NO_EM_RESTART': '1', 02:39:21 INFO - 'PAGER': '/bin/cat', 02:39:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:21 INFO - 'PWD': '/builds/slave/test', 02:39:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:21 INFO - 'SHELL': '/bin/bash', 02:39:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qo5Bb8FBCH/Listeners', 02:39:21 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 02:39:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:21 INFO - 'USER': 'cltbld', 02:39:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:21 INFO - 'XPC_FLAGS': '0x0', 02:39:21 INFO - 'XPC_SERVICE_NAME': '0', 02:39:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:21 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-FFnhZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:21 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-SsqJQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:21 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-zYdgSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:21 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-vdikk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:21 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-6S5thK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:21 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-9tj6z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:21 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-JAN5d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:22 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-yIPadB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:22 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-AuFPFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:22 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-KhyTXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:22 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-qoyqcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:22 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-KhHp1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:22 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-CE3boZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:22 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-YDBL1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:22 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-iMPwkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:22 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Mk5PGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:23 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-OqofUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:39:23 INFO - Running setup.py install for manifestparser 02:39:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:39:23 INFO - Running setup.py install for mozcrash 02:39:23 INFO - Running setup.py install for mozdebug 02:39:23 INFO - Running setup.py install for mozdevice 02:39:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:39:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:39:23 INFO - Running setup.py install for mozfile 02:39:23 INFO - Running setup.py install for mozhttpd 02:39:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:39:23 INFO - Running setup.py install for mozinfo 02:39:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Running setup.py install for mozInstall 02:39:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Running setup.py install for mozleak 02:39:24 INFO - Running setup.py install for mozlog 02:39:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Running setup.py install for moznetwork 02:39:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Running setup.py install for mozprocess 02:39:24 INFO - Running setup.py install for mozprofile 02:39:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:39:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:39:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:39:25 INFO - Running setup.py install for mozrunner 02:39:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:39:25 INFO - Running setup.py install for mozscreenshot 02:39:25 INFO - Running setup.py install for moztest 02:39:25 INFO - Running setup.py install for mozversion 02:39:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:39:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:39:25 INFO - Cleaning up... 02:39:25 INFO - Return code: 0 02:39:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe80d9a6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf0d30>, '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 0x10fb54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fce7b20>, '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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v75AYWRJzm/Render', 02:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:25 INFO - 'HOME': '/Users/cltbld', 02:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:25 INFO - 'LOGNAME': 'cltbld', 02:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:25 INFO - 'MOZ_NO_REMOTE': '1', 02:39:25 INFO - 'NO_EM_RESTART': '1', 02:39:25 INFO - 'PAGER': '/bin/cat', 02:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:25 INFO - 'PWD': '/builds/slave/test', 02:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:25 INFO - 'SHELL': '/bin/bash', 02:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qo5Bb8FBCH/Listeners', 02:39:25 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 02:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:25 INFO - 'USER': 'cltbld', 02:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:25 INFO - 'XPC_FLAGS': '0x0', 02:39:25 INFO - 'XPC_SERVICE_NAME': '0', 02:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:25 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Vqjj08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:26 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-_03XTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:26 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:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:26 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-bM4rvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:26 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-VM0gbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:26 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-kmaOrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:26 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-UXFVOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:26 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-L0BDp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:26 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-pKc7_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:26 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-l58U7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:26 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:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:26 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-J6564P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:26 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:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:26 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-eAfnLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:27 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-KkxTED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:27 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ZEdHxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:27 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-WcBR1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:27 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-1j8NdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:27 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-pXuOQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:27 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Tdc1I2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:39:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:30 INFO - Downloading blessings-1.6.tar.gz 02:39:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:39:30 INFO - Installing collected packages: blessings 02:39:30 INFO - Running setup.py install for blessings 02:39:30 INFO - Successfully installed blessings 02:39:30 INFO - Cleaning up... 02:39:30 INFO - Return code: 0 02:39:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:39:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:30 INFO - Reading from file tmpfile_stdout 02:39:30 INFO - Current package versions: 02:39:30 INFO - blessings == 1.6 02:39:30 INFO - blobuploader == 1.2.4 02:39:30 INFO - docopt == 0.6.1 02:39:30 INFO - manifestparser == 1.1 02:39:30 INFO - mozInstall == 1.12 02:39:30 INFO - mozcrash == 0.17 02:39:30 INFO - mozdebug == 0.1 02:39:30 INFO - mozdevice == 0.48 02:39:30 INFO - mozfile == 1.2 02:39:30 INFO - mozhttpd == 0.7 02:39:30 INFO - mozinfo == 0.9 02:39:30 INFO - mozleak == 0.1 02:39:30 INFO - mozlog == 3.1 02:39:30 INFO - moznetwork == 0.27 02:39:30 INFO - mozprocess == 0.22 02:39:30 INFO - mozprofile == 0.28 02:39:30 INFO - mozrunner == 6.11 02:39:30 INFO - mozscreenshot == 0.1 02:39:30 INFO - mozsystemmonitor == 0.0 02:39:30 INFO - moztest == 0.7 02:39:30 INFO - mozversion == 1.4 02:39:30 INFO - psutil == 3.1.1 02:39:30 INFO - requests == 1.2.3 02:39:30 INFO - wsgiref == 0.1.2 02:39:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39: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:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe80d9a6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf0d30>, '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 0x10fb54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fce7b20>, '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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:39:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v75AYWRJzm/Render', 02:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:30 INFO - 'HOME': '/Users/cltbld', 02:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:30 INFO - 'LOGNAME': 'cltbld', 02:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:30 INFO - 'MOZ_NO_REMOTE': '1', 02:39:30 INFO - 'NO_EM_RESTART': '1', 02:39:30 INFO - 'PAGER': '/bin/cat', 02:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:30 INFO - 'PWD': '/builds/slave/test', 02:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:30 INFO - 'SHELL': '/bin/bash', 02:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qo5Bb8FBCH/Listeners', 02:39:30 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 02:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:30 INFO - 'USER': 'cltbld', 02:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:30 INFO - 'XPC_FLAGS': '0x0', 02:39:30 INFO - 'XPC_SERVICE_NAME': '0', 02:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:39:31 INFO - Cleaning up... 02:39:31 INFO - Return code: 0 02:39:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe80d9a6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf0d30>, '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 0x10fb54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fce7b20>, '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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:39:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:39:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v75AYWRJzm/Render', 02:39:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:31 INFO - 'HOME': '/Users/cltbld', 02:39:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:31 INFO - 'LOGNAME': 'cltbld', 02:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:31 INFO - 'MOZ_NO_REMOTE': '1', 02:39:31 INFO - 'NO_EM_RESTART': '1', 02:39:31 INFO - 'PAGER': '/bin/cat', 02:39:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:31 INFO - 'PWD': '/builds/slave/test', 02:39:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:31 INFO - 'SHELL': '/bin/bash', 02:39:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qo5Bb8FBCH/Listeners', 02:39:31 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 02:39:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:31 INFO - 'USER': 'cltbld', 02:39:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:31 INFO - 'XPC_FLAGS': '0x0', 02:39:31 INFO - 'XPC_SERVICE_NAME': '0', 02:39:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:31 INFO - Downloading/unpacking jsonschema 02:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:39:34 INFO - Downloading/unpacking functools32 (from jsonschema) 02:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:34 INFO - Downloading functools32-3.2.3-2.tar.gz 02:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:39:34 INFO - warning: no files found matching '*.txt' 02:39:34 INFO - no previously-included directories found matching 'build' 02:39:34 INFO - no previously-included directories found matching 'dist' 02:39:34 INFO - no previously-included directories found matching '.git*' 02:39:34 INFO - Installing collected packages: jsonschema, functools32 02:39:34 INFO - Running setup.py install for functools32 02:39:34 INFO - warning: no files found matching '*.txt' 02:39:34 INFO - no previously-included directories found matching 'build' 02:39:34 INFO - no previously-included directories found matching 'dist' 02:39:34 INFO - no previously-included directories found matching '.git*' 02:39:34 INFO - Successfully installed jsonschema functools32 02:39:34 INFO - Cleaning up... 02:39:34 INFO - Return code: 0 02:39:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:39: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:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe534c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe80d9a6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf0d30>, '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 0x10fb54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fce7b20>, '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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:39:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v75AYWRJzm/Render', 02:39:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:34 INFO - 'HOME': '/Users/cltbld', 02:39:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:34 INFO - 'LOGNAME': 'cltbld', 02:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:34 INFO - 'MOZ_NO_REMOTE': '1', 02:39:34 INFO - 'NO_EM_RESTART': '1', 02:39:34 INFO - 'PAGER': '/bin/cat', 02:39:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:34 INFO - 'PWD': '/builds/slave/test', 02:39:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:34 INFO - 'SHELL': '/bin/bash', 02:39:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qo5Bb8FBCH/Listeners', 02:39:34 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 02:39:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:34 INFO - 'USER': 'cltbld', 02:39:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:34 INFO - 'XPC_FLAGS': '0x0', 02:39:34 INFO - 'XPC_SERVICE_NAME': '0', 02:39:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:35 INFO - Downloading/unpacking flake8 02:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:39:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:39:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:39:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:39:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:39:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:39:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:39:39 INFO - no previously-included directories found matching 'docs/_build' 02:39:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:39:39 INFO - Running setup.py install for pep8 02:39:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:39:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:39:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:39:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:39:39 INFO - no previously-included directories found matching 'docs/_build' 02:39:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:39:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:39:39 INFO - Cleaning up... 02:39:39 INFO - Return code: 0 02:39:39 INFO - Running post-action listener: _resource_record_post_action 02:39:39 INFO - Running post-action listener: _start_resource_monitoring 02:39:39 INFO - Starting resource monitoring. 02:39:39 INFO - ##### 02:39:39 INFO - ##### Running install step. 02:39:39 INFO - ##### 02:39:39 INFO - Running pre-action listener: _resource_record_pre_action 02:39:39 INFO - Running main action method: install 02:39:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:39 INFO - Reading from file tmpfile_stdout 02:39:39 INFO - Detecting whether we're running mozinstall >=1.0... 02:39:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:39:40 INFO - Reading from file tmpfile_stdout 02:39:40 INFO - Output received: 02:39:40 INFO - Usage: mozinstall [options] installer 02:39:40 INFO - Options: 02:39:40 INFO - -h, --help show this help message and exit 02:39:40 INFO - -d DEST, --destination=DEST 02:39:40 INFO - Directory to install application into. [default: 02:39:40 INFO - "/builds/slave/test"] 02:39:40 INFO - --app=APP Application being installed. [default: firefox] 02:39:40 INFO - mkdir: /builds/slave/test/build/application 02:39:40 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:39:40 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:40:12 INFO - Reading from file tmpfile_stdout 02:40:12 INFO - Output received: 02:40:12 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:40:12 INFO - Running post-action listener: _resource_record_post_action 02:40:12 INFO - ##### 02:40:12 INFO - ##### Running run-tests step. 02:40:12 INFO - ##### 02:40:12 INFO - Running pre-action listener: _resource_record_pre_action 02:40:12 INFO - Running main action method: run_tests 02:40:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:40:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:40:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:40:12 INFO - 2016-03-23 02:40:12.397 screenresolution[1641:7372] starting screenresolution argv=screenresolution get 02:40:12 INFO - 2016-03-23 02:40:12.400 screenresolution[1641:7372] Display 0: 1600x1200x32@60 02:40:12 INFO - 2016-03-23 02:40:12.406 screenresolution[1642:7375] starting screenresolution argv=screenresolution list 02:40:12 INFO - Available Modes on Display 0 02:40:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:40:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:40:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:40:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:40:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:40:12 INFO - Intel Iris: 02:40:12 INFO - Chipset Model: Intel Iris 02:40:12 INFO - Type: GPU 02:40:12 INFO - Bus: Built-In 02:40:12 INFO - VRAM (Dynamic, Max): 1536 MB 02:40:12 INFO - Vendor: Intel (0x8086) 02:40:12 INFO - Device ID: 0x0a2e 02:40:12 INFO - Revision ID: 0x0009 02:40:12 INFO - Displays: 02:40:12 INFO - Display: 02:40:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:40:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:40:12 INFO - Display Serial Number: 1600x1200 60 02:40:12 INFO - Main Display: Yes 02:40:12 INFO - Mirror: Off 02:40:12 INFO - Online: Yes 02:40:12 INFO - Rotation: Supported 02:40:12 INFO - Return code: 0 02:40:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:40:12 INFO - Python 2.7.3 02:40:12 INFO - Return code: 0 02:40:12 INFO - grabbing minidump binary from tooltool 02:40: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:40:12 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 0x10fcf0d30>, '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 0x10fb54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fce7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:40:12 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:40:12 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:40:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:40:12 INFO - Return code: 0 02:40:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:40:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:40:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:40:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:40:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:40:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:40:13 INFO - Return code: 0 02:40:13 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/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--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:40:13 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/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0159 --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:40:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v75AYWRJzm/Render', 02:40:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:40:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:40:13 INFO - 'HOME': '/Users/cltbld', 02:40:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:40:13 INFO - 'LOGNAME': 'cltbld', 02:40:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:40:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:13 INFO - 'MOZ_NO_REMOTE': '1', 02:40:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:40:13 INFO - 'NO_EM_RESTART': '1', 02:40:13 INFO - 'PAGER': '/bin/cat', 02:40:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:13 INFO - 'PWD': '/builds/slave/test', 02:40:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:40:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:40:13 INFO - 'SHELL': '/bin/bash', 02:40:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qo5Bb8FBCH/Listeners', 02:40:13 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 02:40:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:40:13 INFO - 'USER': 'cltbld', 02:40:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:40:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:13 INFO - 'XPC_FLAGS': '0x0', 02:40:13 INFO - 'XPC_SERVICE_NAME': '0', 02:40:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:40:13 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/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--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:40:14 INFO - mozversion application_buildid: 20160323004040 02:40:14 INFO - mozversion application_changeset: 5c247ef4c02899a3ab3cf4626ae2eaf40868b493 02:40:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:40:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:40:14 INFO - mozversion application_name: Firefox 02:40:14 INFO - mozversion application_remotingname: firefox-dev 02:40:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:40:14 INFO - mozversion application_vendor: Mozilla 02:40:14 INFO - mozversion application_version: 47.0a2 02:40:14 INFO - mozversion platform_buildid: 20160323004040 02:40:14 INFO - mozversion platform_changeset: 5c247ef4c02899a3ab3cf4626ae2eaf40868b493 02:40:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:40:14 INFO - mozversion platform_version: 47.0a2 02:40:14 INFO - using testdate: 1458726014 02:40:14 INFO - actual date: 1458726014 02:40:14 INFO - starting webserver on 'localhost:49283' 02:40:14 INFO - SUITE-START | Running 2 tests 02:40:14 INFO - TEST-START | dromaeo_css 02:40:14 INFO - operating with platform_type : mac_ 02:40:14 INFO - Initialising browser for dromaeo_css test... 02:40:14 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpLgIcmX/profile http://localhost:49283/getInfo.html) 02:40:16 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 02:40:16 INFO - PROCESS | 1660 | colorDepth:24 02:40:16 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 02:40:16 INFO - PROCESS | 1660 | __metrics 02:40:16 INFO - PROCESS | 1660 | 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:40:16 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:40:17 INFO - TEST-INFO | 1660: exit 0 02:40:17 INFO - Browser initialized. 02:40:17 INFO - Running cycle 1/1 for dromaeo_css test... 02:40:17 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpLgIcmX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:29 INFO - PROCESS | 1663 | RSS: Main: 210370560 02:40:29 INFO - PROCESS | 1663 | 02:41:19 INFO - PROCESS | 1663 | 1458726079887 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:43:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 02:43:31 INFO - PROCESS | 1663 | RSS: Main: 322703360 02:43:31 INFO - PROCESS | 1663 | 02:46:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 02:46:34 INFO - PROCESS | 1663 | RSS: Main: 339156992 02:46:34 INFO - PROCESS | 1663 | 02:49:36 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 02:49:36 INFO - PROCESS | 1663 | RSS: Main: 346808320 02:49:36 INFO - PROCESS | 1663 | 02:52:38 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 02:52:39 INFO - PROCESS | 1663 | RSS: Main: 305881088 02:52:39 INFO - PROCESS | 1663 | 02:55:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 02:55:42 INFO - PROCESS | 1663 | RSS: Main: 307318784 02:55:42 INFO - PROCESS | 1663 | 02:58:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 02:58:45 INFO - PROCESS | 1663 | RSS: Main: 372125696 02:58:45 INFO - PROCESS | 1663 | 02:58:45 INFO - PROCESS | 1663 | __start_tp_report 02:58:45 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 02:58:45 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 02:58:45 INFO - PROCESS | 1663 | |i|pagename|runs| 02:58:45 INFO - PROCESS | 1663 | |0;dojo.html;2693.3805224798307;2911.9126426207213;3310.586176727909;3534.2578058607683;3595.3528364894323;5791.942080579193;5805.390434004422;5813.128030795383;5817.534597232222;5827.038538641124;5751.022326204545;5829.650220986733;5839.9124013139835;5878.23582934219;5898.7935422260225;5119.462456442057;5174.534291913727;5246.081935661254;5320.334958130234;5350.117230656937;5326.946730532703;5329.893402131955;5331.893362132774;5335;5354.571634269249;5119.7696103675235;5139.203423469368;5151.227315902607;5163.66436181647;5343.759530821103;5334;5361.624686271963;5369.194620806871;5390.730463476811;5417.26866872971;4207.537170911197;5235.110031294651;5257.447967963385;5265.736713164365;5308.787648494055;5675.51758100562;5703.515201207861;5712.571557133231;5751.3961034091235;5755.251817263771;6142.907856382113;6211.3167551569295;6214.1300217969065;6248.125262463259;6252.6561039142825;6188.907166392508;6206.34833342497;6215.1609532712955;6237;6245.437910588069;5907.527397808165;5913.349531551526;5942.435468630473;5947.5539334550085;5969.820905372846;6213.782517611862;6250.156228909039;6335.3981371769605;6372.904406433907;6372.968135159294;6112.321110680095;6173.47525460332;6186.505079593711;6204.162438070893;6212.968935155295;6172.105044768573;6209.751609935643;6211.16149319845;6213.502919766408;6231.594946328474;6090.908636370458;6155.045967874897;6175.907361389583;6202.596831205957;6215.502759779207;6174.536909731788;6186.10301506279;6191.226096737908;6234.0337247726675;6241.188645476059;4939.555440010345;4943.209086546135;4947.134251505972;4963.305137280783;4971.850844474671;3847.9807600961817;4304.913901721948;4442.3336499524685;4443.933340999887;4472.172648060119;4934.259861020875;5790.218320526759;5869.06095024794;5885.941140588539;5922.170896074553;6257.7809776658505;6284.497240220771;6303.086052522359;6303.527235457359;6311.368863113652;5678.290213723285;5821.359650438449;5880.353161152269;5888.882222355529;5911.261092363455;5341.252224688546;5362.8659283517445;5387.595930305243;5406.162044883049;5408.810691625853;6311.652859092794;6314.778982735582;6360.777372792023;6363.204599425072;6365.2998170201245;6225.875482490234;6239.594426362272;6240.843978900564;6258.092576576462;6302.401271879165;6335.936640633535;6370.1718776558755;6373.5857169283845;6375.394337537927;6395.104685343963;6202.131701561875;6208.627482351073;6211.937880621317;6245.375462453719;6251.218597675291;6140.62695141751;6205.844853878689;6257.4681152102585;6276;6315.4947604192475;5969.716510949993;6155.84610384744;6189.752409903554;6197.659128747962;6205.410486003822;6160.661163636043;6202.472789812736;6202.875942481215;6203.720832562455;6226.533010024175;5855.707214639337;5989.431004054608;6077.875593015307;6087.543434242361;6119.082137679384;6153.261608606996;6178.907316390348;6189.566730328834;6203.16257305276;6217;5819.563532734977;6040.879182416415;6056.727447264796;6080.357187349014;6117.235345581802 02:58:45 INFO - PROCESS | 1663 | |1;ext.html;509.9566536844368;595.2262059322879;599.7584999051965;672.8326353776198;676.3811112831758;31657.208569785766;31903.840480797593;31942.68057319432;32028;32045.679543204562;33918.32163356731;41592.96017599561;42060.78969605148;42094.57905420945;42115;9612.134907858273;9777.266704997119;9801.41191528507;9804.117629413351;9807.166390856786;9617.32678712487;9770.609175632966;9771.413715177112;9776.853347199798;9782.755431114208;9733.464659443727;9761.853572196424;9762.389205781037;9773;9809.313348065638;9749.415035097882;9816.705498835046;9818.312718109735;9830.21358291335;9837.901620983841;8336.333093352518;9655.46894920779;9745.90254097457;9753.21974242059;9760.560774765081;41726.1654766906;42178;42239.366409503884;42301.365479517524;42338.78830605858;3232.4181647303476;3341.4820702791108;3744.101415660249;3837.6929845612563;4001.1197536541913;28375.71624283772;29623.851880740458;29730;29907.401851962837;29944.550831737324;2786.6934637190097;2818.309514169021;2820.4641118187683;2840.4603125406106;2873.109336105814;488256;489085;489310;493226;494229;47304.7634761824;64484.677576612754;64810;64923.67538162279;64956;46277;46416;46504.3024354635;46524;46689.5331046692;16759.2458339375;16905.408310709314;16928.49214523566;16931.984080955182;16934.49196524106;13701.588952331445;13739.931300343434;13758.862411375958;13779.655508612164;13799.448022079205;15070;15089.849101509064;15298.847011529964;15302.770458443132;15449.5365139046;5537.750801213955;5716.28546431696;6796.626185559841;6851.931480685229;6855.691493882788;948.6632245552868;998.1615443027746;1010.802893435773;1107.95568177272;1137.2096393006782;30687;30975.0707478776;31546.211344716106;31693;32113.197170070467;1150.056953298304;1190.15498995714;1209.1294268126935;1214.2714371377103;1261.3504045416619;13598.32008399576;16077.35690572364;16101.597460063593;16398.918005410134;16471.91764041172;640056;644882;655512;658086;658652;59745.402545973986;60319.09521357183;60403.69798150981;60435;60489;1430.8354539228121;1468.258529442646;1534.1025500082353;1538.9461368851812;1573.1347758732652;28891;28975.85512072426;29179.124626261248;29797;29920.850395747882;46843.531564683915;47090.76454617705;47445.762771185924;47516.52483475259;47545.04909901852;376221;379559;382367;382435;383723;28259.01093461719;32654;33077.50383744294;33309.16727081843;33430.33139337151;40086.599134008284;40676.3898541528;41384.793076034424;41941.58058419499;42308;33330;33791.3241735159;34809.69307915744;35324.29351412906;35599.64400355963;34067;34326;34529.82735086309;34961.475577865844;35038.82480587683;35142.12144696403;35465.1133721659;35719;36178.27643447064;36441.27117457689;30745.231369215948;31550;31599.84200079077;31734.682653174095;31753.206169845016;23836.404089897893;24198.87900560486;24344.51310973806;24392.75607243976;24457 02:58:45 INFO - PROCESS | 1663 | |2;jquery.html;339.4822895084994;377.1758707224714;377.2982253009404;382.1478103828463;385.0143632301307;16996.915015424922;17932.46202613922;21464.463388415297;22143.778562214375;22187.66718499224;21098.156073757033;21193.258235961704;21447.249346272885;21622.89188554055;21623.567528649455;5211.218317252405;5811.622244554101;6136.7545298188015;6137.508999280047;6179.196704428418;5666.348369937468;6006.069059295816;6014.1580178775;6015.488683461911;6017.518598512109;5919.23050003499;5932.584719069667;5963.970180149093;5966.910496342537;5969.925413425582;5630.5495560355075;5934.614250073774;5949.583529152961;5954.106883967418;5960.612560183596;5186.844394668166;5193.350831146106;5210.192420174879;5211.2443695663915;5211.609129315279;23887.163949261867;25024.624630630555;26107.869460652764;27303.180904572895;27331.043413480435;1789.74943507909;2100.873947563151;2146.742390913085;2153.493928926701;2196.8681879087308;9025.41334813235;9530.666426675032;9553.426794392359;9927.2058235341;14734.70530589393;1674.4223242981152;1709.6495218480181;1781.8841775284695;1799.5591080185307;1834.550535118891;106818;112400.99999999919;112444;113955;117202.24196637057;10493.895061049445;11056.617922759655;11909.583164589198;11956;11976.820347694791;14553.636159096108;14609.488667896572;14630.63423414402;14654.413823446943;14659.413623454942;8039.718609848627;8044.356451483867;8045.477043992122;8113.716019939274;8153.55155466455;7656.196099409593;7657.310842024244;7665.540067595962;7740.496867703694;7768.689252429839;4625.514320996314;4657.60410365116;4671.929921051187;4673.439187297478;4730.219513780187;1674.489280769377;1919.7504324437734;1953.9413817585496;1955.6675365187668;1963.577830766392;954.5370495309769;970.4662435660358;996.5166894056376;1047.617619568852;1073.5115522437272;20645.483862903548;20647.58704825925;21383.03776330069;21822;21952.45118872009;975.5414954971152;984.5520288268964;985.556499575194;1000.4047591683083;1029.0892560084378;9492.382995105296;10795.514201860935;11210.21528493014;11246.887531124748;11284.322940623424;521014;568340;631914;661693.6915315393;670409;133412;135427;139626;140569;140639;1036;1060.7083052160717;1072.3190773858655;1075.2258373970728;1076.5855145768778;18248.087595620433;18337.816621833612;18536.25854965786;19657.705134422707;20072.397828065183;24931.87534062318;50859.98280034453;51489.742551287;52052.21921671102;53842.73078634582;67734;69489.61020779658;70338.59322813617;71610.64194678994;73098.63450682712;8094.757157285291;8218.83562328762;8264.917350826414;8310.168983101641;8562.91437085646;12581.496740130293;12948.287844168284;13056.34718264102;13186.604401867959;13623.18260904349;9805.607775688892;11464.31214127155;11549.826752598885;11565.537378504765;11617.477213525242;11171.66485005451;11201.103911687209;11499.425028748361;11546.307221566733;11679.240849344766;11401.20191586581;11579.768404631692;11826.113041522092;11837.289762614271;11900;8194.549299788569;8199.180081991992;8217.260446559838;8282.1303763104;8619.224269815746;8611.183251093633;11163.386013769321;11206.551737930391;11535.5962541314;11671.941640291745 02:58:45 INFO - PROCESS | 1663 | |3;mootools.html;1535.1633359818898;1668.1659170414794;1695.762593236947;2065.9690104648434;2135.679648052791;8428.325733941285;8965.820683586333;9108.40795348302;9124.041975592567;9141.314401419886;7349.853002939938;9173.862392064124;9183.357164998453;9196.724098277045;9197.356185067049;2275.533515629292;2343.16817529777;2343.9648405273933;2547.1467058535413;2582.9225123246333;2489.9915534208585;2559.053150334379;2564.9358766030814;2565.9101931432406;2566.871656417181;2506.1604362538574;2546.2106746908516;2559.9488010239784;2567.743225677436;2572.4597834454694;2521.1050077222503;2538.2765911715164;2549.7195308516048;2552.310876063462;2572.8456292622313;2508.234988328559;2518.2948774343213;2518.546661600911;2519.508695804319;2537.7589129032713;9325.906740932573;9391.530423478798;9393.107654772786;9403.90596094044;9428.669996550156;5242.6330156889035;5492.835214943558;5698.658080515141;5780.7687692492245;5795.2176456178295;3721.6464435878547;3773.5471743390694;3845.788481633509;3854.3447613905705;3866.729328946975;1065.7016035509992;1086.7717779266363;1096.3421946831836;1105.7677887643604;1107.7839821234863;12739.363031848463;12756.489740410372;12786.552470663482;12794.104412691115;12805;5064.392272927273;5097.923531147036;5177.352830896138;5196.948030519722;5222.97388513055;10738.087262582612;10772.515236814363;10782.514786834612;10786;10792.676219713421;5805.535557155417;5812.94187058124;5814.098814683731;5814.709264536757;5821.330546987066;4617.676762626651;4805.1590971579835;4961.652684312064;5220.451852555503;5227.790888364499;4110.712250142461;4147.792610369469;4167.8958026049595;4202.705810593229;4213.557576454489;1346.6700658338573;1365.3241645385597;1369.7260547890262;1378.4141739760562;1381.7374698807193;1407.2260256858688;1423.4235134770433;1443.8483959184343;1445.9638509037359;1464.4435114656576;8394.664213431517;8616.353773467015;8667.0032946212;8671.132886711279;8681.479111253346;527.8442859356499;527.9208118782213;530.7316303227266;539.2881396556586;541.4098632490604;6367.331430199855;6404.615723056631;6420.06908998202;6429.1320671709655;6447.161868957006;11108.277961932448;11496.482658280398;11621.418929053514;11630.953214210762;11975.640730777915;8460.280876125475;10902.182336324808;11193.888061119285;11296.717582060513;11300.491477883515;7199.352058314672;8754.649814007496;8775.122487751301;8818.823623527494;8839.29285657146;8238.134995825352;8324.25081742646;8335.166483351617;8419;8478.067412584487;9512;9897.604095836086;9931.900680993387;10023.749406264902;10310.32982856112;9966.900330996597;10144.442055687008;10158;10224;10249.180065594883;7379.8155046124275;7654.655540500579;7668.309852113337;7677.808054798451;7681.61591920413;8604.48373097616;8624.741257762276;8689.522076285864;8693.565321733762;8704;6562.639054852029;7569.3566046884425;7662.501937374052;7751.496152750054;7857.567833769198;7576.545407275581;7622;7642.273983971514;7785.338246249133;7797.610119494116;8113;8169.2647661710735;8176.01887773471;8192.75421737349;8194.83610327802;6535.477161827138;6641.605262894846;6991.126109236346;7140.285971402818;7160.248173941869;7497.737579184703;7499.475036747375;7542;7547.924520754942;7548.811279718051 02:58:45 INFO - PROCESS | 1663 | |4;prototype.html;334.5500302093684;338.1090825674349;344.18256640478864;345.1285504102141;349.53686365565613;6568.835779105519;6581.374769396905;6583.967080164599;6612.966935165329;6635;6561.704723287452;6564.2451118121435;6571.310012448684;6587.670616469181;6594.4065034146915;4704.270838020112;4769.880752981168;4833.444153922291;4870.123377791996;4948.010397920412;3972.801359932006;4897.510248975092;4903.068417000776;4906.828261010865;4937.827176048839;4932.852014439554;4933.161362568354;4934.827281045164;4947.975260123712;4951.0592987332475;4691.835785747499;4791.808327666889;4897.33885925399;4912.508749125094;4913.705177689314;4221.810018549173;4225.176090662322;4227.985283531961;4228.365745138223;4241.915161696779;6235.376462353728;6331.620102793847;6338.492920566389;6362;6367.07677386781;5821.573714439989;5838.124281357788;5843.766249350021;5851.093080572518;5860.033094539396;6765.458763298924;6977.476689248276;7009.684564194624;7012.5792452453015;7032.437405007587;3872.6320999505;4733;4749.073930583538;4758.547937945889;4764.785584648699;6481.773137940197;6889.242183359826;7316.9634151828905;7405.8518829623645;7432.888506672351;4826.686265392808;4843.297721830315;4846.055019271208;4848.248521479177;4852.611791056707;4899.412070551557;4919.77860996256;4923.532264434873;4924.75376231187;4931.284963680247;5820.621659592113;5836.358000619928;5836.416358364129;5838.620489668243;5847.06446968483;6778.559393639398;6939.028536004963;6959.1996920353795;7035.683394247271;7051.307686155285;1620.7082725109358;1651.3229575873834;1657.6353202295475;1657.734762438004;1659.8340165983548;980.8234517786724;1033.565902321027;1058.444316733721;1061.9097376722912;1088.0588291128274;6517.837054073686;6633.767818126343;6638.767643132467;6648.5678430901835;6697.464202863759;6003.699815009232;7384.52000619958;7415.555066696015;7418.517796343221;7426.925730742623;5613.691246981455;6565.868682626321;6669.499787515859;6678.098456708282;6704.564203326768;3853.2871418787613;3887.5334959805004;3900.0444891001885;3903.59012303704;3904.0630248740667;7430.777076687708;7755.108162561265;7766.106897706723;7778.688852445952;7780.572068536172;6298.401651843067;6911.274316196827;7609.809754756176;7657.272559106876;7678.8080297993;6436.937905245582;7538.623068846536;7717.344025757873;7762.573058481725;7765.990421245315;6983.231844497;7357.558546487228;7368.37368823656;7371.520851144658;7379.483436159418;5878.531016972967;7181.640917954186;7190.568565886064;7201.819954501179;7247.9637601813765;7685.961570192113;7693.49992250502;7694.384449244159;7710.730124445618;7720.073591169095;3977.284088864032;4661.3707149534375;4705.976470117627;4707.8587642370785;4719.0561887621925;6022.76533310679;7308.671109799965;7314;7336.96331518339;7342.5227360221415;5730.455606717355;7082.5042247044275;7120.074390329224;7123.465740069619;7125.3230943060325;7022.789316320519;7104.254053324326;7110.968909508196;7114.750983715545;7115.67979440916;5927.4665280125;6230.563860529719;6327.082573026977;6937.895931561132;6944.305569443218;6846.657667116724;7063.82340441493;7102.644867756695;7107.466939979626;7148.499605027599;6564.901526477202;6705.731770729116;6741.494387921024;6839.452843772586;6929.203141638574 02:58:45 INFO - PROCESS | 1663 | |5;yui.html;699.164498424383;771.8109063279497;790.0835031363617;808.830145669409;820.4420993724265;14461.204633745154;14656.340464679088;14659.340329685163;14659.926700366497;14670.19313937733;12781.872181278184;12784.42470088846;12817.935910320459;12819.294938778386;12858.292793896355;919.4253591505326;995.6117114325419;998.2413365841976;998.4857798233879;1000.7648202672366;987.4174237200051;990.3810118675827;994.9403035817838;996.0885789502596;996.2727209137298;1047.3977462958792;1050.9421981791;1054.5781687325093;1055.7993981143597;1057.148995058977;1048.3709774135534;1049.2707568240114;1049.5591851422382;1049.92125590581;1053.3627155570923;780.5784876166863;782.284209947897;782.4913806026071;783.0251337085365;784.6037750935798;14337.06809057408;14391;14392.136471811726;14403.207823569699;14408.567742967623;13078.738425231537;13177.472901083946;13239.940804735597;13246.668833279246;13504;9906.157976572;9967.45179015154;10133.746656333577;10196.133328667072;10656.09423199029;3512.6858053432366;3550.6449355064547;3593.7125029997537;3595.8202089895663;3669.376206044979;85980.14019859784;88462.67305990415;88751.55624221837;88762;88806.55596721976;9478.857817132748;9574.760630984141;9793.412395256308;9844.409335439897;9875.20998320147;22846.657300140512;22984.4253893654;23036.76963230346;23045.654315185286;23088.884555577115;7441.627918604048;7457.776266712007;7618.238176182337;7680.500767450098;7795.532268063935;2994.715502027304;3973.523177218752;4020.115574573589;4138.13099249161;4273.572642735764;3661.5423072115987;3678.319510890494;3711.536057992751;3725.2363265530503;3738.1028553147594;661.490652197805;672.8217022489044;673.2964052564984;677.0386051806447;694.4236283884364;545.9863503412447;584.260909948915;589.4370875813588;589.6255877517722;604.2296072507588;7760.185180556074;7918.485298455582;7928.445008849325;7988.440809143421;8041.3164880984605;518.7198912587161;567.738840133535;599.9490043346277;601.717192919336;609.2049874913192;3658.487811706363;3701.204241088179;3701.592824789271;3777.7166712496673;3846.615338466131;94349;96006;96060;96135;97753.5112324448;78115.8282625761;82261;82480;83568.58215708882;83853;55699.72150139305;76987;77676;77769;79305;8046.718364857436;8061.530827440764;8091.259576408166;8279.089300176855;8285.088640249447;49375;49972;51566.484335156165;52394.95210095853;52628;70958.29041709517;71464.64267678629;72337.27662723305;73401;73799.63100184465;11366.090712743126;11588.826167607323;11705.648830535098;11782.941085294518;12429.937850310691;11979.640610781691;12171.391430428266;12312;12600.495980161058;12633.178843375152;11359.886401135884;11683.474243659226;11753;11944.522219111139;11955.64133076009;11410.942945285553;11941.94029029884;12001.579944701894;12013;12059.51761929513;9640.903590964;11402.600908968147;11682.299062056303;11801.232919860182;11810.291382517076;7670.961645191738;9210.907890921273;9222.216111630587;9394.718158455258;9499.38254013487;8530.061693213618;8619.094995025433;8657.826843463221;8733.650653974024;8835.911640883509 02:58:45 INFO - PROCESS | 1663 | __end_tp_report 02:58:45 INFO - PROCESS | 1663 | __start_cc_report 02:58:45 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1018 02:58:45 INFO - PROCESS | 1663 | __end_cc_report 02:58:45 INFO - PROCESS | 1663 | __startTimestamp1458727125954__endTimestamp 02:58:45 INFO - PROCESS | 1663 | 02:58:45 INFO - PROCESS | 1663 | ------- Summary: start ------- 02:58:45 INFO - PROCESS | 1663 | Number of tests: 6 02:58:45 INFO - PROCESS | 1663 | 02:58:45 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5777.61 Median:6080.36 stddev:682.39 (11.2%) stddev-sans-first:640.15 02:58:45 INFO - PROCESS | 1663 | Values: 2693.4 2911.9 3310.6 3534.3 3595.4 5791.9 5805.4 5813.1 5817.5 5827.0 5751.0 5829.7 5839.9 5878.2 5898.8 5119.5 5174.5 5246.1 5320.3 5350.1 5326.9 5329.9 5331.9 5335.0 5354.6 5119.8 5139.2 5151.2 5163.7 5343.8 5334.0 5361.6 5369.2 5390.7 5417.3 4207.5 5235.1 5257.4 5265.7 5308.8 5675.5 5703.5 5712.6 5751.4 5755.3 6142.9 6211.3 6214.1 6248.1 6252.7 6188.9 6206.3 6215.2 6237.0 6245.4 5907.5 5913.3 5942.4 5947.6 5969.8 6213.8 6250.2 6335.4 6372.9 6373.0 6112.3 6173.5 6186.5 6204.2 6213.0 6172.1 6209.8 6211.2 6213.5 6231.6 6090.9 6155.0 6175.9 6202.6 6215.5 6174.5 6186.1 6191.2 6234.0 6241.2 4939.6 4943.2 4947.1 4963.3 4971.9 3848.0 4304.9 4442.3 4443.9 4472.2 4934.3 5790.2 5869.1 5885.9 5922.2 6257.8 6284.5 6303.1 6303.5 6311.4 5678.3 5821.4 5880.4 5888.9 5911.3 5341.3 5362.9 5387.6 5406.2 5408.8 6311.7 6314.8 6360.8 6363.2 6365.3 6225.9 6239.6 6240.8 6258.1 6302.4 6335.9 6370.2 6373.6 6375.4 6395.1 6202.1 6208.6 6211.9 6245.4 6251.2 6140.6 6205.8 6257.5 6276.0 6315.5 5969.7 6155.8 6189.8 6197.7 6205.4 6160.7 6202.5 6202.9 6203.7 6226.5 5855.7 5989.4 6077.9 6087.5 6119.1 6153.3 6178.9 6189.6 6203.2 6217.0 5819.6 6040.9 6056.7 6080.4 6117.2 02:58:45 INFO - PROCESS | 1663 | 02:58:45 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:64016.30 Median:20092.69 stddev:138965.63 (691.6%) stddev-sans-first:139273.67 02:58:45 INFO - PROCESS | 1663 | Values: 510.0 595.2 599.8 672.8 676.4 31657.2 31903.8 31942.7 32028.0 32045.7 33918.3 41593.0 42060.8 42094.6 42115.0 9612.1 9777.3 9801.4 9804.1 9807.2 9617.3 9770.6 9771.4 9776.9 9782.8 9733.5 9761.9 9762.4 9773.0 9809.3 9749.4 9816.7 9818.3 9830.2 9837.9 8336.3 9655.5 9745.9 9753.2 9760.6 41726.2 42178.0 42239.4 42301.4 42338.8 3232.4 3341.5 3744.1 3837.7 4001.1 28375.7 29623.9 29730.0 29907.4 29944.6 2786.7 2818.3 2820.5 2840.5 2873.1 488256.0 489085.0 489310.0 493226.0 494229.0 47304.8 64484.7 64810.0 64923.7 64956.0 46277.0 46416.0 46504.3 46524.0 46689.5 16759.2 16905.4 16928.5 16932.0 16934.5 13701.6 13739.9 13758.9 13779.7 13799.4 15070.0 15089.8 15298.8 15302.8 15449.5 5537.8 5716.3 6796.6 6851.9 6855.7 948.7 998.2 1010.8 1108.0 1137.2 30687.0 30975.1 31546.2 31693.0 32113.2 1150.1 1190.2 1209.1 1214.3 1261.4 13598.3 16077.4 16101.6 16398.9 16471.9 640056.0 644882.0 655512.0 658086.0 658652.0 59745.4 60319.1 60403.7 60435.0 60489.0 1430.8 1468.3 1534.1 1538.9 1573.1 28891.0 28975.9 29179.1 29797.0 29920.9 46843.5 47090.8 47445.8 47516.5 47545.0 376221.0 379559.0 382367.0 382435.0 383723.0 28259.0 32654.0 33077.5 33309.2 33430.3 40086.6 40676.4 41384.8 41941.6 42308.0 33330.0 33791.3 34809.7 35324.3 35599.6 34067.0 34326.0 34529.8 34961.5 35038.8 35142.1 35465.1 35719.0 36178.3 36441.3 30745.2 31550.0 31599.8 31734.7 31753.2 23836.4 24198.9 24344.5 24392.8 24457.0 02:58:45 INFO - PROCESS | 1663 | 02:58:45 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35188.69 Median:22165.72 stddev:102305.72 (461.5%) stddev-sans-first:102559.25 02:58:45 INFO - PROCESS | 1663 | Values: 339.5 377.2 377.3 382.1 385.0 16996.9 17932.5 21464.5 22143.8 22187.7 21098.2 21193.3 21447.2 21622.9 21623.6 5211.2 5811.6 6136.8 6137.5 6179.2 5666.3 6006.1 6014.2 6015.5 6017.5 5919.2 5932.6 5964.0 5966.9 5969.9 5630.5 5934.6 5949.6 5954.1 5960.6 5186.8 5193.4 5210.2 5211.2 5211.6 23887.2 25024.6 26107.9 27303.2 27331.0 1789.7 2100.9 2146.7 2153.5 2196.9 9025.4 9530.7 9553.4 9927.2 14734.7 1674.4 1709.6 1781.9 1799.6 1834.6 106818.0 112401.0 112444.0 113955.0 117202.2 10493.9 11056.6 11909.6 11956.0 11976.8 14553.6 14609.5 14630.6 14654.4 14659.4 8039.7 8044.4 8045.5 8113.7 8153.6 7656.2 7657.3 7665.5 7740.5 7768.7 4625.5 4657.6 4671.9 4673.4 4730.2 1674.5 1919.8 1953.9 1955.7 1963.6 954.5 970.5 996.5 1047.6 1073.5 20645.5 20647.6 21383.0 21822.0 21952.5 975.5 984.6 985.6 1000.4 1029.1 9492.4 10795.5 11210.2 11246.9 11284.3 521014.0 568340.0 631914.0 661693.7 670409.0 133412.0 135427.0 139626.0 140569.0 140639.0 1036.0 1060.7 1072.3 1075.2 1076.6 18248.1 18337.8 18536.3 19657.7 20072.4 24931.9 50860.0 51489.7 52052.2 53842.7 67734.0 69489.6 70338.6 71610.6 73098.6 8094.8 8218.8 8264.9 8310.2 8562.9 12581.5 12948.3 13056.3 13186.6 13623.2 9805.6 11464.3 11549.8 11565.5 11617.5 11171.7 11201.1 11499.4 11546.3 11679.2 11401.2 11579.8 11826.1 11837.3 11900.0 8194.5 8199.2 8217.3 8282.1 8619.2 8611.2 11163.4 11206.6 11535.6 11671.9 02:58:45 INFO - PROCESS | 1663 | 02:58:45 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6312.05 Median:2885.24 stddev:3372.18 (116.9%) stddev-sans-first:3362.53 02:58:45 INFO - PROCESS | 1663 | Values: 1535.2 1668.2 1695.8 2066.0 2135.7 8428.3 8965.8 9108.4 9124.0 9141.3 7349.9 9173.9 9183.4 9196.7 9197.4 2275.5 2343.2 2344.0 2547.1 2582.9 2490.0 2559.1 2564.9 2565.9 2566.9 2506.2 2546.2 2559.9 2567.7 2572.5 2521.1 2538.3 2549.7 2552.3 2572.8 2508.2 2518.3 2518.5 2519.5 2537.8 9325.9 9391.5 9393.1 9403.9 9428.7 5242.6 5492.8 5698.7 5780.8 5795.2 3721.6 3773.5 3845.8 3854.3 3866.7 1065.7 1086.8 1096.3 1105.8 1107.8 12739.4 12756.5 12786.6 12794.1 12805.0 5064.4 5097.9 5177.4 5196.9 5223.0 10738.1 10772.5 10782.5 10786.0 10792.7 5805.5 5812.9 5814.1 5814.7 5821.3 4617.7 4805.2 4961.7 5220.5 5227.8 4110.7 4147.8 4167.9 4202.7 4213.6 1346.7 1365.3 1369.7 1378.4 1381.7 1407.2 1423.4 1443.8 1446.0 1464.4 8394.7 8616.4 8667.0 8671.1 8681.5 527.8 527.9 530.7 539.3 541.4 6367.3 6404.6 6420.1 6429.1 6447.2 11108.3 11496.5 11621.4 11631.0 11975.6 8460.3 10902.2 11193.9 11296.7 11300.5 7199.4 8754.6 8775.1 8818.8 8839.3 8238.1 8324.3 8335.2 8419.0 8478.1 9512.0 9897.6 9931.9 10023.7 10310.3 9966.9 10144.4 10158.0 10224.0 10249.2 7379.8 7654.7 7668.3 7677.8 7681.6 8604.5 8624.7 8689.5 8693.6 8704.0 6562.6 7569.4 7662.5 7751.5 7857.6 7576.5 7622.0 7642.3 7785.3 7797.6 8113.0 8169.3 8176.0 8192.8 8194.8 6535.5 6641.6 6991.1 7140.3 7160.2 7497.7 7499.5 7542.0 7547.9 7548.8 02:58:45 INFO - PROCESS | 1663 | 02:58:45 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5760.18 Median:6539.77 stddev:1818.83 (27.8%) stddev-sans-first:1777.76 02:58:45 INFO - PROCESS | 1663 | Values: 334.6 338.1 344.2 345.1 349.5 6568.8 6581.4 6584.0 6613.0 6635.0 6561.7 6564.2 6571.3 6587.7 6594.4 4704.3 4769.9 4833.4 4870.1 4948.0 3972.8 4897.5 4903.1 4906.8 4937.8 4932.9 4933.2 4934.8 4948.0 4951.1 4691.8 4791.8 4897.3 4912.5 4913.7 4221.8 4225.2 4228.0 4228.4 4241.9 6235.4 6331.6 6338.5 6362.0 6367.1 5821.6 5838.1 5843.8 5851.1 5860.0 6765.5 6977.5 7009.7 7012.6 7032.4 3872.6 4733.0 4749.1 4758.5 4764.8 6481.8 6889.2 7317.0 7405.9 7432.9 4826.7 4843.3 4846.1 4848.2 4852.6 4899.4 4919.8 4923.5 4924.8 4931.3 5820.6 5836.4 5836.4 5838.6 5847.1 6778.6 6939.0 6959.2 7035.7 7051.3 1620.7 1651.3 1657.6 1657.7 1659.8 980.8 1033.6 1058.4 1061.9 1088.1 6517.8 6633.8 6638.8 6648.6 6697.5 6003.7 7384.5 7415.6 7418.5 7426.9 5613.7 6565.9 6669.5 6678.1 6704.6 3853.3 3887.5 3900.0 3903.6 3904.1 7430.8 7755.1 7766.1 7778.7 7780.6 6298.4 6911.3 7609.8 7657.3 7678.8 6436.9 7538.6 7717.3 7762.6 7766.0 6983.2 7357.6 7368.4 7371.5 7379.5 5878.5 7181.6 7190.6 7201.8 7248.0 7686.0 7693.5 7694.4 7710.7 7720.1 3977.3 4661.4 4706.0 4707.9 4719.1 6022.8 7308.7 7314.0 7337.0 7342.5 5730.5 7082.5 7120.1 7123.5 7125.3 7022.8 7104.3 7111.0 7114.8 7115.7 5927.5 6230.6 6327.1 6937.9 6944.3 6846.7 7063.8 7102.6 7107.5 7148.5 6564.9 6705.7 6741.5 6839.5 6929.2 02:58:45 INFO - PROCESS | 1663 | 02:58:45 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:19000.92 Median:28133.73 stddev:27297.34 (97.0%) stddev-sans-first:27339.32 02:58:45 INFO - PROCESS | 1663 | Values: 699.2 771.8 790.1 808.8 820.4 14461.2 14656.3 14659.3 14659.9 14670.2 12781.9 12784.4 12817.9 12819.3 12858.3 919.4 995.6 998.2 998.5 1000.8 987.4 990.4 994.9 996.1 996.3 1047.4 1050.9 1054.6 1055.8 1057.1 1048.4 1049.3 1049.6 1049.9 1053.4 780.6 782.3 782.5 783.0 784.6 14337.1 14391.0 14392.1 14403.2 14408.6 13078.7 13177.5 13239.9 13246.7 13504.0 9906.2 9967.5 10133.7 10196.1 10656.1 3512.7 3550.6 3593.7 3595.8 3669.4 85980.1 88462.7 88751.6 88762.0 88806.6 9478.9 9574.8 9793.4 9844.4 9875.2 22846.7 22984.4 23036.8 23045.7 23088.9 7441.6 7457.8 7618.2 7680.5 7795.5 2994.7 3973.5 4020.1 4138.1 4273.6 3661.5 3678.3 3711.5 3725.2 3738.1 661.5 672.8 673.3 677.0 694.4 546.0 584.3 589.4 589.6 604.2 7760.2 7918.5 7928.4 7988.4 8041.3 518.7 567.7 599.9 601.7 609.2 3658.5 3701.2 3701.6 3777.7 3846.6 94349.0 96006.0 96060.0 96135.0 97753.5 78115.8 82261.0 82480.0 83568.6 83853.0 55699.7 76987.0 77676.0 77769.0 79305.0 8046.7 8061.5 8091.3 8279.1 8285.1 49375.0 49972.0 51566.5 52395.0 52628.0 70958.3 71464.6 72337.3 73401.0 73799.6 11366.1 11588.8 11705.6 11782.9 12429.9 11979.6 12171.4 12312.0 12600.5 12633.2 11359.9 11683.5 11753.0 11944.5 11955.6 11410.9 11941.9 12001.6 12013.0 12059.5 9640.9 11402.6 11682.3 11801.2 11810.3 7671.0 9210.9 9222.2 9394.7 9499.4 8530.1 8619.1 8657.8 8733.7 8835.9 02:58:45 INFO - PROCESS | 1663 | -------- Summary: end -------- 02:58:45 INFO - PROCESS | 1663 | 02:58:46 INFO - TEST-INFO | 1663: exit 0 02:58:46 INFO - TEST-OK | dromaeo_css | took 1112379ms 02:58:46 INFO - TEST-START | kraken 02:58:46 INFO - operating with platform_type : mac_ 02:58:46 INFO - Initialising browser for kraken test... 02:58:46 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpvbXapV/profile http://localhost:49283/getInfo.html) 02:58:48 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 02:58:48 INFO - PROCESS | 1673 | colorDepth:24 02:58:48 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 02:58:48 INFO - PROCESS | 1673 | __metrics 02:58:48 INFO - PROCESS | 1673 | 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:58:48 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:58:49 INFO - TEST-INFO | 1673: exit 0 02:58:49 INFO - Browser initialized. 02:58:49 INFO - Running cycle 1/1 for kraken test... 02:58:49 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpvbXapV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:59:01 INFO - PROCESS | 1676 | RSS: Main: 209055744 02:59:01 INFO - PROCESS | 1676 | 02:59:03 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 02:59:04 INFO - PROCESS | 1676 | RSS: Main: 264749056 02:59:04 INFO - PROCESS | 1676 | 02:59:07 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 02:59:07 INFO - PROCESS | 1676 | RSS: Main: 274833408 02:59:07 INFO - PROCESS | 1676 | 02:59:10 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 02:59:11 INFO - PROCESS | 1676 | RSS: Main: 264609792 02:59:11 INFO - PROCESS | 1676 | 02:59:13 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 02:59:14 INFO - PROCESS | 1676 | RSS: Main: 266633216 02:59:14 INFO - PROCESS | 1676 | 02:59:16 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:59:16 INFO - PROCESS | 1676 | RSS: Main: 266735616 02:59:16 INFO - PROCESS | 1676 | 02:59:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 02:59:19 INFO - PROCESS | 1676 | RSS: Main: 267325440 02:59:19 INFO - PROCESS | 1676 | 02:59:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 02:59:23 INFO - PROCESS | 1676 | RSS: Main: 267382784 02:59:23 INFO - PROCESS | 1676 | 02:59:26 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 02:59:26 INFO - PROCESS | 1676 | RSS: Main: 266575872 02:59:26 INFO - PROCESS | 1676 | 02:59:28 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:59:29 INFO - PROCESS | 1676 | RSS: Main: 300064768 02:59:29 INFO - PROCESS | 1676 | 02:59:30 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:59:31 INFO - PROCESS | 1676 | RSS: Main: 300756992 02:59:31 INFO - PROCESS | 1676 | 02:59:33 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:59:34 INFO - PROCESS | 1676 | RSS: Main: 308383744 02:59:34 INFO - PROCESS | 1676 | 02:59:36 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:59:37 INFO - PROCESS | 1676 | RSS: Main: 309764096 02:59:37 INFO - PROCESS | 1676 | 02:59:39 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:59:40 INFO - PROCESS | 1676 | RSS: Main: 309559296 02:59:40 INFO - PROCESS | 1676 | 02:59:41 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 02:59:42 INFO - PROCESS | 1676 | RSS: Main: 369954816 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | __start_tp_report 02:59:42 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 02:59:42 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 02:59:42 INFO - PROCESS | 1676 | |i|pagename|runs| 02:59:42 INFO - PROCESS | 1676 | |0;ai-astar;112;110;110;109;113;112;120;113;110;110 02:59:42 INFO - PROCESS | 1676 | |1;audio-beat-detection;156;146;165;145;118;139;116;148;148;139 02:59:42 INFO - PROCESS | 1676 | |2;audio-dft;183;183;187;195;184;187;186;186;186;185 02:59:42 INFO - PROCESS | 1676 | |3;audio-fft;73;71;74;115;55;58;57;58;119;56 02:59:42 INFO - PROCESS | 1676 | |4;audio-oscillator;90;95;129;81;78;86;117;76;79;114 02:59:42 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;89;86;89;86;89;85;88;86;88;85 02:59:42 INFO - PROCESS | 1676 | |6;imaging-darkroom;93;94;94;95;95;95;95;96;94;95 02:59:42 INFO - PROCESS | 1676 | |7;imaging-desaturate;107;143;88;85;87;87;84;85;85;85 02:59:42 INFO - PROCESS | 1676 | |8;json-parse-financial;57;58;58;54;57;83;84;96;85;52 02:59:42 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;66;64;74;76;69;66;64;63;65;65 02:59:42 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;80;80;80;81;80;79;78;95;103;86 02:59:42 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;122;120;116;121;114;117;114;113;117;120 02:59:42 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;133;134;132;133;132;122;133;132;133;131 02:59:42 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;65;68;65;63;66;66;66;66;65;66 02:59:42 INFO - PROCESS | 1676 | __end_tp_report 02:59:42 INFO - PROCESS | 1676 | __start_cc_report 02:59:42 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1214 02:59:42 INFO - PROCESS | 1676 | __end_cc_report 02:59:42 INFO - PROCESS | 1676 | __startTimestamp1458727182196__endTimestamp 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | ------- Summary: start ------- 02:59:42 INFO - PROCESS | 1676 | Number of tests: 14 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:3.18 (2.8%) stddev-sans-first:3.37 02:59:42 INFO - PROCESS | 1676 | Values: 112.0 110.0 110.0 109.0 113.0 112.0 120.0 113.0 110.0 110.0 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:147.00 stddev:15.25 (10.4%) stddev-sans-first:15.31 02:59:42 INFO - PROCESS | 1676 | Values: 156.0 146.0 165.0 145.0 118.0 139.0 116.0 148.0 148.0 139.0 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:186.20 Median:186.00 stddev:3.43 (1.8%) stddev-sans-first:3.43 02:59:42 INFO - PROCESS | 1676 | Values: 183.0 183.0 187.0 195.0 184.0 187.0 186.0 186.0 186.0 185.0 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:73.60 Median:58.00 stddev:24.04 (41.4%) stddev-sans-first:25.50 02:59:42 INFO - PROCESS | 1676 | Values: 73.0 71.0 74.0 115.0 55.0 58.0 57.0 58.0 119.0 56.0 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:80.00 stddev:18.88 (23.6%) stddev-sans-first:19.95 02:59:42 INFO - PROCESS | 1676 | Values: 90.0 95.0 129.0 81.0 78.0 86.0 117.0 76.0 79.0 114.0 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:88.00 stddev:1.66 (1.9%) stddev-sans-first:1.62 02:59:42 INFO - PROCESS | 1676 | Values: 89.0 86.0 89.0 86.0 89.0 85.0 88.0 86.0 88.0 85.0 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.84 (0.9%) stddev-sans-first:0.67 02:59:42 INFO - PROCESS | 1676 | Values: 93.0 94.0 94.0 95.0 95.0 95.0 95.0 96.0 94.0 95.0 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:85.00 stddev:18.64 (21.9%) stddev-sans-first:19.13 02:59:42 INFO - PROCESS | 1676 | Values: 107.0 143.0 88.0 85.0 87.0 87.0 84.0 85.0 85.0 85.0 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:70.50 stddev:16.49 (23.4%) stddev-sans-first:16.96 02:59:42 INFO - PROCESS | 1676 | Values: 57.0 58.0 58.0 54.0 57.0 83.0 84.0 96.0 85.0 52.0 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:66.00 stddev:4.44 (6.7%) stddev-sans-first:4.69 02:59:42 INFO - PROCESS | 1676 | Values: 66.0 64.0 74.0 76.0 69.0 66.0 64.0 63.0 65.0 65.0 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:80.00 stddev:8.30 (10.4%) stddev-sans-first:8.66 02:59:42 INFO - PROCESS | 1676 | Values: 80.0 80.0 80.0 81.0 80.0 79.0 78.0 95.0 103.0 86.0 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:118.50 stddev:3.20 (2.7%) stddev-sans-first:2.93 02:59:42 INFO - PROCESS | 1676 | Values: 122.0 120.0 116.0 121.0 114.0 117.0 114.0 113.0 117.0 120.0 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.50 Median:133.00 stddev:3.44 (2.6%) stddev-sans-first:3.61 02:59:42 INFO - PROCESS | 1676 | Values: 133.0 134.0 132.0 133.0 132.0 122.0 133.0 132.0 133.0 131.0 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 02:59:42 INFO - PROCESS | 1676 | Values: 65.0 68.0 65.0 63.0 66.0 66.0 66.0 66.0 65.0 66.0 02:59:42 INFO - PROCESS | 1676 | -------- Summary: end -------- 02:59:42 INFO - PROCESS | 1676 | 02:59:42 INFO - TEST-INFO | 1676: exit 0 02:59:42 INFO - TEST-OK | kraken | took 56344ms 02:59:42 INFO - SUITE-END | took 1168s 02:59:43 INFO - Completed test suite (00:19:29) 02:59:43 INFO - javascript benchmark 02:59:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2693.3805224798307, 2911.9126426207213, 3310.586176727909, 3534.2578058607683, 3595.3528364894323, 5791.942080579193, 5805.390434004422, 5813.128030795383, 5817.534597232222, 5827.038538641124, 5751.022326204545, 5829.650220986733, 5839.9124013139835, 5878.23582934219, 5898.7935422260225, 5119.462456442057, 5174.534291913727, 5246.081935661254, 5320.334958130234, 5350.117230656937, 5326.946730532703, 5329.893402131955, 5331.893362132774, 5335.0, 5354.571634269249, 5119.7696103675235, 5139.203423469368, 5151.227315902607, 5163.66436181647, 5343.759530821103, 5334.0, 5361.624686271963, 5369.194620806871, 5390.730463476811, 5417.26866872971, 4207.537170911197, 5235.110031294651, 5257.447967963385, 5265.736713164365, 5308.787648494055, 5675.51758100562, 5703.515201207861, 5712.571557133231, 5751.3961034091235, 5755.251817263771, 6142.907856382113, 6211.3167551569295, 6214.1300217969065, 6248.125262463259, 6252.6561039142825, 6188.907166392508, 6206.34833342497, 6215.1609532712955, 6237.0, 6245.437910588069, 5907.527397808165, 5913.349531551526, 5942.435468630473, 5947.5539334550085, 5969.820905372846, 6213.782517611862, 6250.156228909039, 6335.3981371769605, 6372.904406433907, 6372.968135159294, 6112.321110680095, 6173.47525460332, 6186.505079593711, 6204.162438070893, 6212.968935155295, 6172.105044768573, 6209.751609935643, 6211.16149319845, 6213.502919766408, 6231.594946328474, 6090.908636370458, 6155.045967874897, 6175.907361389583, 6202.596831205957, 6215.502759779207, 6174.536909731788, 6186.10301506279, 6191.226096737908, 6234.0337247726675, 6241.188645476059, 4939.555440010345, 4943.209086546135, 4947.134251505972, 4963.305137280783, 4971.850844474671, 3847.9807600961817, 4304.913901721948, 4442.3336499524685, 4443.933340999887, 4472.172648060119, 4934.259861020875, 5790.218320526759, 5869.06095024794, 5885.941140588539, 5922.170896074553, 6257.7809776658505, 6284.497240220771, 6303.086052522359, 6303.527235457359, 6311.368863113652, 5678.290213723285, 5821.359650438449, 5880.353161152269, 5888.882222355529, 5911.261092363455, 5341.252224688546, 5362.8659283517445, 5387.595930305243, 5406.162044883049, 5408.810691625853, 6311.652859092794, 6314.778982735582, 6360.777372792023, 6363.204599425072, 6365.2998170201245, 6225.875482490234, 6239.594426362272, 6240.843978900564, 6258.092576576462, 6302.401271879165, 6335.936640633535, 6370.1718776558755, 6373.5857169283845, 6375.394337537927, 6395.104685343963, 6202.131701561875, 6208.627482351073, 6211.937880621317, 6245.375462453719, 6251.218597675291, 6140.62695141751, 6205.844853878689, 6257.4681152102585, 6276.0, 6315.4947604192475, 5969.716510949993, 6155.84610384744, 6189.752409903554, 6197.659128747962, 6205.410486003822, 6160.661163636043, 6202.472789812736, 6202.875942481215, 6203.720832562455, 6226.533010024175, 5855.707214639337, 5989.431004054608, 6077.875593015307, 6087.543434242361, 6119.082137679384, 6153.261608606996, 6178.907316390348, 6189.566730328834, 6203.16257305276, 6217.0, 5819.563532734977, 6040.879182416415, 6056.727447264796, 6080.357187349014, 6117.235345581802], "unit": "score", "name": "dojo.html", "value": 5730.215211008252}, {"lowerIsBetter": false, "replicates": [509.9566536844368, 595.2262059322879, 599.7584999051965, 672.8326353776198, 676.3811112831758, 31657.208569785766, 31903.840480797593, 31942.68057319432, 32028.0, 32045.679543204562, 33918.32163356731, 41592.96017599561, 42060.78969605148, 42094.57905420945, 42115.0, 9612.134907858273, 9777.266704997119, 9801.41191528507, 9804.117629413351, 9807.166390856786, 9617.32678712487, 9770.609175632966, 9771.413715177112, 9776.853347199798, 9782.755431114208, 9733.464659443727, 9761.853572196424, 9762.389205781037, 9773.0, 9809.313348065638, 9749.415035097882, 9816.705498835046, 9818.312718109735, 9830.21358291335, 9837.901620983841, 8336.333093352518, 9655.46894920779, 9745.90254097457, 9753.21974242059, 9760.560774765081, 41726.1654766906, 42178.0, 42239.366409503884, 42301.365479517524, 42338.78830605858, 3232.4181647303476, 3341.4820702791108, 3744.101415660249, 3837.6929845612563, 4001.1197536541913, 28375.71624283772, 29623.851880740458, 29730.0, 29907.401851962837, 29944.550831737324, 2786.6934637190097, 2818.309514169021, 2820.4641118187683, 2840.4603125406106, 2873.109336105814, 488256.0, 489085.0, 489310.0, 493226.0, 494229.0, 47304.7634761824, 64484.677576612754, 64810.0, 64923.67538162279, 64956.0, 46277.0, 46416.0, 46504.3024354635, 46524.0, 46689.5331046692, 16759.2458339375, 16905.408310709314, 16928.49214523566, 16931.984080955182, 16934.49196524106, 13701.588952331445, 13739.931300343434, 13758.862411375958, 13779.655508612164, 13799.448022079205, 15070.0, 15089.849101509064, 15298.847011529964, 15302.770458443132, 15449.5365139046, 5537.750801213955, 5716.28546431696, 6796.626185559841, 6851.931480685229, 6855.691493882788, 948.6632245552868, 998.1615443027746, 1010.802893435773, 1107.95568177272, 1137.2096393006782, 30687.0, 30975.0707478776, 31546.211344716106, 31693.0, 32113.197170070467, 1150.056953298304, 1190.15498995714, 1209.1294268126935, 1214.2714371377103, 1261.3504045416619, 13598.32008399576, 16077.35690572364, 16101.597460063593, 16398.918005410134, 16471.91764041172, 640056.0, 644882.0, 655512.0, 658086.0, 658652.0, 59745.402545973986, 60319.09521357183, 60403.69798150981, 60435.0, 60489.0, 1430.8354539228121, 1468.258529442646, 1534.1025500082353, 1538.9461368851812, 1573.1347758732652, 28891.0, 28975.85512072426, 29179.124626261248, 29797.0, 29920.850395747882, 46843.531564683915, 47090.76454617705, 47445.762771185924, 47516.52483475259, 47545.04909901852, 376221.0, 379559.0, 382367.0, 382435.0, 383723.0, 28259.01093461719, 32654.0, 33077.50383744294, 33309.16727081843, 33430.33139337151, 40086.599134008284, 40676.3898541528, 41384.793076034424, 41941.58058419499, 42308.0, 33330.0, 33791.3241735159, 34809.69307915744, 35324.29351412906, 35599.64400355963, 34067.0, 34326.0, 34529.82735086309, 34961.475577865844, 35038.82480587683, 35142.12144696403, 35465.1133721659, 35719.0, 36178.27643447064, 36441.27117457689, 30745.231369215948, 31550.0, 31599.84200079077, 31734.682653174095, 31753.206169845016, 23836.404089897893, 24198.87900560486, 24344.51310973806, 24392.75607243976, 24457.0], "unit": "score", "name": "ext.html", "value": 19401.042255208748}, {"lowerIsBetter": false, "replicates": [339.4822895084994, 377.1758707224714, 377.2982253009404, 382.1478103828463, 385.0143632301307, 16996.915015424922, 17932.46202613922, 21464.463388415297, 22143.778562214375, 22187.66718499224, 21098.156073757033, 21193.258235961704, 21447.249346272885, 21622.89188554055, 21623.567528649455, 5211.218317252405, 5811.622244554101, 6136.7545298188015, 6137.508999280047, 6179.196704428418, 5666.348369937468, 6006.069059295816, 6014.1580178775, 6015.488683461911, 6017.518598512109, 5919.23050003499, 5932.584719069667, 5963.970180149093, 5966.910496342537, 5969.925413425582, 5630.5495560355075, 5934.614250073774, 5949.583529152961, 5954.106883967418, 5960.612560183596, 5186.844394668166, 5193.350831146106, 5210.192420174879, 5211.2443695663915, 5211.609129315279, 23887.163949261867, 25024.624630630555, 26107.869460652764, 27303.180904572895, 27331.043413480435, 1789.74943507909, 2100.873947563151, 2146.742390913085, 2153.493928926701, 2196.8681879087308, 9025.41334813235, 9530.666426675032, 9553.426794392359, 9927.2058235341, 14734.70530589393, 1674.4223242981152, 1709.6495218480181, 1781.8841775284695, 1799.5591080185307, 1834.550535118891, 106818.0, 112400.99999999919, 112444.0, 113955.0, 117202.24196637057, 10493.895061049445, 11056.617922759655, 11909.583164589198, 11956.0, 11976.820347694791, 14553.636159096108, 14609.488667896572, 14630.63423414402, 14654.413823446943, 14659.413623454942, 8039.718609848627, 8044.356451483867, 8045.477043992122, 8113.716019939274, 8153.55155466455, 7656.196099409593, 7657.310842024244, 7665.540067595962, 7740.496867703694, 7768.689252429839, 4625.514320996314, 4657.60410365116, 4671.929921051187, 4673.439187297478, 4730.219513780187, 1674.489280769377, 1919.7504324437734, 1953.9413817585496, 1955.6675365187668, 1963.577830766392, 954.5370495309769, 970.4662435660358, 996.5166894056376, 1047.617619568852, 1073.5115522437272, 20645.483862903548, 20647.58704825925, 21383.03776330069, 21822.0, 21952.45118872009, 975.5414954971152, 984.5520288268964, 985.556499575194, 1000.4047591683083, 1029.0892560084378, 9492.382995105296, 10795.514201860935, 11210.21528493014, 11246.887531124748, 11284.322940623424, 521014.0, 568340.0, 631914.0, 661693.6915315393, 670409.0, 133412.0, 135427.0, 139626.0, 140569.0, 140639.0, 1036.0, 1060.7083052160717, 1072.3190773858655, 1075.2258373970728, 1076.5855145768778, 18248.087595620433, 18337.816621833612, 18536.25854965786, 19657.705134422707, 20072.397828065183, 24931.87534062318, 50859.98280034453, 51489.742551287, 52052.21921671102, 53842.73078634582, 67734.0, 69489.61020779658, 70338.59322813617, 71610.64194678994, 73098.63450682712, 8094.757157285291, 8218.83562328762, 8264.917350826414, 8310.168983101641, 8562.91437085646, 12581.496740130293, 12948.287844168284, 13056.34718264102, 13186.604401867959, 13623.18260904349, 9805.607775688892, 11464.31214127155, 11549.826752598885, 11565.537378504765, 11617.477213525242, 11171.66485005451, 11201.103911687209, 11499.425028748361, 11546.307221566733, 11679.240849344766, 11401.20191586581, 11579.768404631692, 11826.113041522092, 11837.289762614271, 11900.0, 8194.549299788569, 8199.180081991992, 8217.260446559838, 8282.1303763104, 8619.224269815746, 8611.183251093633, 11163.386013769321, 11206.551737930391, 11535.5962541314, 11671.941640291745], "unit": "score", "name": "jquery.html", "value": 9565.485584306134}, {"lowerIsBetter": false, "replicates": [1535.1633359818898, 1668.1659170414794, 1695.762593236947, 2065.9690104648434, 2135.679648052791, 8428.325733941285, 8965.820683586333, 9108.40795348302, 9124.041975592567, 9141.314401419886, 7349.853002939938, 9173.862392064124, 9183.357164998453, 9196.724098277045, 9197.356185067049, 2275.533515629292, 2343.16817529777, 2343.9648405273933, 2547.1467058535413, 2582.9225123246333, 2489.9915534208585, 2559.053150334379, 2564.9358766030814, 2565.9101931432406, 2566.871656417181, 2506.1604362538574, 2546.2106746908516, 2559.9488010239784, 2567.743225677436, 2572.4597834454694, 2521.1050077222503, 2538.2765911715164, 2549.7195308516048, 2552.310876063462, 2572.8456292622313, 2508.234988328559, 2518.2948774343213, 2518.546661600911, 2519.508695804319, 2537.7589129032713, 9325.906740932573, 9391.530423478798, 9393.107654772786, 9403.90596094044, 9428.669996550156, 5242.6330156889035, 5492.835214943558, 5698.658080515141, 5780.7687692492245, 5795.2176456178295, 3721.6464435878547, 3773.5471743390694, 3845.788481633509, 3854.3447613905705, 3866.729328946975, 1065.7016035509992, 1086.7717779266363, 1096.3421946831836, 1105.7677887643604, 1107.7839821234863, 12739.363031848463, 12756.489740410372, 12786.552470663482, 12794.104412691115, 12805.0, 5064.392272927273, 5097.923531147036, 5177.352830896138, 5196.948030519722, 5222.97388513055, 10738.087262582612, 10772.515236814363, 10782.514786834612, 10786.0, 10792.676219713421, 5805.535557155417, 5812.94187058124, 5814.098814683731, 5814.709264536757, 5821.330546987066, 4617.676762626651, 4805.1590971579835, 4961.652684312064, 5220.451852555503, 5227.790888364499, 4110.712250142461, 4147.792610369469, 4167.8958026049595, 4202.705810593229, 4213.557576454489, 1346.6700658338573, 1365.3241645385597, 1369.7260547890262, 1378.4141739760562, 1381.7374698807193, 1407.2260256858688, 1423.4235134770433, 1443.8483959184343, 1445.9638509037359, 1464.4435114656576, 8394.664213431517, 8616.353773467015, 8667.0032946212, 8671.132886711279, 8681.479111253346, 527.8442859356499, 527.9208118782213, 530.7316303227266, 539.2881396556586, 541.4098632490604, 6367.331430199855, 6404.615723056631, 6420.06908998202, 6429.1320671709655, 6447.161868957006, 11108.277961932448, 11496.482658280398, 11621.418929053514, 11630.953214210762, 11975.640730777915, 8460.280876125475, 10902.182336324808, 11193.888061119285, 11296.717582060513, 11300.491477883515, 7199.352058314672, 8754.649814007496, 8775.122487751301, 8818.823623527494, 8839.29285657146, 8238.134995825352, 8324.25081742646, 8335.166483351617, 8419.0, 8478.067412584487, 9512.0, 9897.604095836086, 9931.900680993387, 10023.749406264902, 10310.32982856112, 9966.900330996597, 10144.442055687008, 10158.0, 10224.0, 10249.180065594883, 7379.8155046124275, 7654.655540500579, 7668.309852113337, 7677.808054798451, 7681.61591920413, 8604.48373097616, 8624.741257762276, 8689.522076285864, 8693.565321733762, 8704.0, 6562.639054852029, 7569.3566046884425, 7662.501937374052, 7751.496152750054, 7857.567833769198, 7576.545407275581, 7622.0, 7642.273983971514, 7785.338246249133, 7797.610119494116, 8113.0, 8169.2647661710735, 8176.01887773471, 8192.75421737349, 8194.83610327802, 6535.477161827138, 6641.605262894846, 6991.126109236346, 7140.285971402818, 7160.248173941869, 7497.737579184703, 7499.475036747375, 7542.0, 7547.924520754942, 7548.811279718051], "unit": "score", "name": "mootools.html", "value": 5059.325368396957}, {"lowerIsBetter": false, "replicates": [334.5500302093684, 338.1090825674349, 344.18256640478864, 345.1285504102141, 349.53686365565613, 6568.835779105519, 6581.374769396905, 6583.967080164599, 6612.966935165329, 6635.0, 6561.704723287452, 6564.2451118121435, 6571.310012448684, 6587.670616469181, 6594.4065034146915, 4704.270838020112, 4769.880752981168, 4833.444153922291, 4870.123377791996, 4948.010397920412, 3972.801359932006, 4897.510248975092, 4903.068417000776, 4906.828261010865, 4937.827176048839, 4932.852014439554, 4933.161362568354, 4934.827281045164, 4947.975260123712, 4951.0592987332475, 4691.835785747499, 4791.808327666889, 4897.33885925399, 4912.508749125094, 4913.705177689314, 4221.810018549173, 4225.176090662322, 4227.985283531961, 4228.365745138223, 4241.915161696779, 6235.376462353728, 6331.620102793847, 6338.492920566389, 6362.0, 6367.07677386781, 5821.573714439989, 5838.124281357788, 5843.766249350021, 5851.093080572518, 5860.033094539396, 6765.458763298924, 6977.476689248276, 7009.684564194624, 7012.5792452453015, 7032.437405007587, 3872.6320999505, 4733.0, 4749.073930583538, 4758.547937945889, 4764.785584648699, 6481.773137940197, 6889.242183359826, 7316.9634151828905, 7405.8518829623645, 7432.888506672351, 4826.686265392808, 4843.297721830315, 4846.055019271208, 4848.248521479177, 4852.611791056707, 4899.412070551557, 4919.77860996256, 4923.532264434873, 4924.75376231187, 4931.284963680247, 5820.621659592113, 5836.358000619928, 5836.416358364129, 5838.620489668243, 5847.06446968483, 6778.559393639398, 6939.028536004963, 6959.1996920353795, 7035.683394247271, 7051.307686155285, 1620.7082725109358, 1651.3229575873834, 1657.6353202295475, 1657.734762438004, 1659.8340165983548, 980.8234517786724, 1033.565902321027, 1058.444316733721, 1061.9097376722912, 1088.0588291128274, 6517.837054073686, 6633.767818126343, 6638.767643132467, 6648.5678430901835, 6697.464202863759, 6003.699815009232, 7384.52000619958, 7415.555066696015, 7418.517796343221, 7426.925730742623, 5613.691246981455, 6565.868682626321, 6669.499787515859, 6678.098456708282, 6704.564203326768, 3853.2871418787613, 3887.5334959805004, 3900.0444891001885, 3903.59012303704, 3904.0630248740667, 7430.777076687708, 7755.108162561265, 7766.106897706723, 7778.688852445952, 7780.572068536172, 6298.401651843067, 6911.274316196827, 7609.809754756176, 7657.272559106876, 7678.8080297993, 6436.937905245582, 7538.623068846536, 7717.344025757873, 7762.573058481725, 7765.990421245315, 6983.231844497, 7357.558546487228, 7368.37368823656, 7371.520851144658, 7379.483436159418, 5878.531016972967, 7181.640917954186, 7190.568565886064, 7201.819954501179, 7247.9637601813765, 7685.961570192113, 7693.49992250502, 7694.384449244159, 7710.730124445618, 7720.073591169095, 3977.284088864032, 4661.3707149534375, 4705.976470117627, 4707.8587642370785, 4719.0561887621925, 6022.76533310679, 7308.671109799965, 7314.0, 7336.96331518339, 7342.5227360221415, 5730.455606717355, 7082.5042247044275, 7120.074390329224, 7123.465740069619, 7125.3230943060325, 7022.789316320519, 7104.254053324326, 7110.968909508196, 7114.750983715545, 7115.67979440916, 5927.4665280125, 6230.563860529719, 6327.082573026977, 6937.895931561132, 6944.305569443218, 6846.657667116724, 7063.82340441493, 7102.644867756695, 7107.466939979626, 7148.499605027599, 6564.901526477202, 6705.731770729116, 6741.494387921024, 6839.452843772586, 6929.203141638574], "unit": "score", "name": "prototype.html", "value": 5156.345800874899}, {"lowerIsBetter": false, "replicates": [699.164498424383, 771.8109063279497, 790.0835031363617, 808.830145669409, 820.4420993724265, 14461.204633745154, 14656.340464679088, 14659.340329685163, 14659.926700366497, 14670.19313937733, 12781.872181278184, 12784.42470088846, 12817.935910320459, 12819.294938778386, 12858.292793896355, 919.4253591505326, 995.6117114325419, 998.2413365841976, 998.4857798233879, 1000.7648202672366, 987.4174237200051, 990.3810118675827, 994.9403035817838, 996.0885789502596, 996.2727209137298, 1047.3977462958792, 1050.9421981791, 1054.5781687325093, 1055.7993981143597, 1057.148995058977, 1048.3709774135534, 1049.2707568240114, 1049.5591851422382, 1049.92125590581, 1053.3627155570923, 780.5784876166863, 782.284209947897, 782.4913806026071, 783.0251337085365, 784.6037750935798, 14337.06809057408, 14391.0, 14392.136471811726, 14403.207823569699, 14408.567742967623, 13078.738425231537, 13177.472901083946, 13239.940804735597, 13246.668833279246, 13504.0, 9906.157976572, 9967.45179015154, 10133.746656333577, 10196.133328667072, 10656.09423199029, 3512.6858053432366, 3550.6449355064547, 3593.7125029997537, 3595.8202089895663, 3669.376206044979, 85980.14019859784, 88462.67305990415, 88751.55624221837, 88762.0, 88806.55596721976, 9478.857817132748, 9574.760630984141, 9793.412395256308, 9844.409335439897, 9875.20998320147, 22846.657300140512, 22984.4253893654, 23036.76963230346, 23045.654315185286, 23088.884555577115, 7441.627918604048, 7457.776266712007, 7618.238176182337, 7680.500767450098, 7795.532268063935, 2994.715502027304, 3973.523177218752, 4020.115574573589, 4138.13099249161, 4273.572642735764, 3661.5423072115987, 3678.319510890494, 3711.536057992751, 3725.2363265530503, 3738.1028553147594, 661.490652197805, 672.8217022489044, 673.2964052564984, 677.0386051806447, 694.4236283884364, 545.9863503412447, 584.260909948915, 589.4370875813588, 589.6255877517722, 604.2296072507588, 7760.185180556074, 7918.485298455582, 7928.445008849325, 7988.440809143421, 8041.3164880984605, 518.7198912587161, 567.738840133535, 599.9490043346277, 601.717192919336, 609.2049874913192, 3658.487811706363, 3701.204241088179, 3701.592824789271, 3777.7166712496673, 3846.615338466131, 94349.0, 96006.0, 96060.0, 96135.0, 97753.5112324448, 78115.8282625761, 82261.0, 82480.0, 83568.58215708882, 83853.0, 55699.72150139305, 76987.0, 77676.0, 77769.0, 79305.0, 8046.718364857436, 8061.530827440764, 8091.259576408166, 8279.089300176855, 8285.088640249447, 49375.0, 49972.0, 51566.484335156165, 52394.95210095853, 52628.0, 70958.29041709517, 71464.64267678629, 72337.27662723305, 73401.0, 73799.63100184465, 11366.090712743126, 11588.826167607323, 11705.648830535098, 11782.941085294518, 12429.937850310691, 11979.640610781691, 12171.391430428266, 12312.0, 12600.495980161058, 12633.178843375152, 11359.886401135884, 11683.474243659226, 11753.0, 11944.522219111139, 11955.64133076009, 11410.942945285553, 11941.94029029884, 12001.579944701894, 12013.0, 12059.51761929513, 9640.903590964, 11402.600908968147, 11682.299062056303, 11801.232919860182, 11810.291382517076, 7670.961645191738, 9210.907890921273, 9222.216111630587, 9394.718158455258, 9499.38254013487, 8530.061693213618, 8619.094995025433, 8657.826843463221, 8733.650653974024, 8835.911640883509], "unit": "score", "name": "yui.html", "value": 7076.191758789918}], "name": "dromaeo_css", "value": 7623.628829630535}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 110.0, 109.0, 113.0, 112.0, 120.0, 113.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [156.0, 146.0, 165.0, 145.0, 118.0, 139.0, 116.0, 148.0, 148.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 142.0}, {"lowerIsBetter": true, "replicates": [183.0, 183.0, 187.0, 195.0, 184.0, 187.0, 186.0, 186.0, 186.0, 185.0], "unit": "score", "name": "audio-dft", "value": 186.2}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 74.0, 115.0, 55.0, 58.0, 57.0, 58.0, 119.0, 56.0], "unit": "score", "name": "audio-fft", "value": 73.6}, {"lowerIsBetter": true, "replicates": [90.0, 95.0, 129.0, 81.0, 78.0, 86.0, 117.0, 76.0, 79.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 94.5}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 89.0, 86.0, 89.0, 85.0, 88.0, 86.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.1}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 94.6}, {"lowerIsBetter": true, "replicates": [107.0, 143.0, 88.0, 85.0, 87.0, 87.0, 84.0, 85.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 93.6}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 58.0, 54.0, 57.0, 83.0, 84.0, 96.0, 85.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 68.4}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 74.0, 76.0, 69.0, 66.0, 64.0, 63.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 80.0, 81.0, 80.0, 79.0, 78.0, 95.0, 103.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [122.0, 120.0, 116.0, 121.0, 114.0, 117.0, 114.0, 113.0, 117.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.4}, {"lowerIsBetter": true, "replicates": [133.0, 134.0, 132.0, 133.0, 132.0, 122.0, 133.0, 132.0, 133.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 131.5}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 65.0, 63.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1417.8000000000002}]} 02:59:43 INFO - Return code: 0 02:59:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:59:43 INFO - # TBPL SUCCESS # 02:59:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:59:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:59:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:59:43 INFO - 2016-03-23 02:59:43.545 screenresolution[1680:9690] starting screenresolution argv=screenresolution get 02:59:43 INFO - 2016-03-23 02:59:43.548 screenresolution[1680:9690] Display 0: 1600x1200x32@60 02:59:43 INFO - 2016-03-23 02:59:43.554 screenresolution[1681:9693] starting screenresolution argv=screenresolution list 02:59:43 INFO - Available Modes on Display 0 02:59:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:59:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:59:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:59:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:59:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:59:43 INFO - Intel Iris: 02:59:43 INFO - Chipset Model: Intel Iris 02:59:43 INFO - Type: GPU 02:59:43 INFO - Bus: Built-In 02:59:43 INFO - VRAM (Dynamic, Max): 1536 MB 02:59:43 INFO - Vendor: Intel (0x8086) 02:59:43 INFO - Device ID: 0x0a2e 02:59:43 INFO - Revision ID: 0x0009 02:59:43 INFO - Displays: 02:59:43 INFO - Display: 02:59:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:59:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:59:43 INFO - Display Serial Number: 1600x1200 60 02:59:43 INFO - Main Display: Yes 02:59:43 INFO - Mirror: Off 02:59:43 INFO - Online: Yes 02:59:43 INFO - Rotation: Supported 02:59:43 INFO - Return code: 0 02:59:43 INFO - Running post-action listener: _resource_record_post_action 02:59:43 INFO - Running post-run listener: _resource_record_post_run 02:59:44 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 37213696; Write bytes: 662351872; Read time: 389; Write time: 2058 02:59:44 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 353870336; Write bytes: 352974336; Read time: 27893; Write time: 658 02:59:44 INFO - run-tests - Wall time: 1171s; CPU: 52.0%; Read bytes: 36259328; Write bytes: 299039232; Read time: 375; Write time: 1368 02:59:44 INFO - Running post-run listener: _upload_blobber_files 02:59:44 INFO - Blob upload gear active. 02:59:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:59:44 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:59:44 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:59:44 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:59:45 INFO - (blobuploader) - INFO - Open directory for files ... 02:59:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:59:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:59:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:46 INFO - (blobuploader) - INFO - Done attempting. 02:59:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:59:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:59:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:47 INFO - (blobuploader) - INFO - Done attempting. 02:59:47 INFO - (blobuploader) - INFO - Iteration through files over. 02:59:47 INFO - Return code: 0 02:59:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:59:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:59:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afe7d5d7f28a34e2dd74fe6992f2eee1b5b7352cd7811f8be8b665dde283e4a5d42577cc27cfda1c9c0249731fdc06dfb95a64357002c9523407f0cd56c25478", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e75e4d64b5e7900765317d0c822910f2faa019102bc71910e9ab2e7c32df49b8e5ada6f4c3764162e1efd793f855d682daa797e75c2fbd8e08892dfd9e0cddc7"} 02:59:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:59:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:59:47 INFO - Contents: 02:59:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afe7d5d7f28a34e2dd74fe6992f2eee1b5b7352cd7811f8be8b665dde283e4a5d42577cc27cfda1c9c0249731fdc06dfb95a64357002c9523407f0cd56c25478", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e75e4d64b5e7900765317d0c822910f2faa019102bc71910e9ab2e7c32df49b8e5ada6f4c3764162e1efd793f855d682daa797e75c2fbd8e08892dfd9e0cddc7"} 02:59:47 INFO - Running post-run listener: copy_logs_to_upload_dir 02:59:47 INFO - Copying logs to upload dir... 02:59:47 INFO - mkdir: /builds/slave/test/build/upload/logs 02:59:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.423768 ========= master_lag: 256.60 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 17 secs) (at 2016-03-23 03:04:04.017085) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 mins, 45 secs) (at 2016-03-23 03:04:04.020289) ========= 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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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/afe7d5d7f28a34e2dd74fe6992f2eee1b5b7352cd7811f8be8b665dde283e4a5d42577cc27cfda1c9c0249731fdc06dfb95a64357002c9523407f0cd56c25478", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e75e4d64b5e7900765317d0c822910f2faa019102bc71910e9ab2e7c32df49b8e5ada6f4c3764162e1efd793f855d682daa797e75c2fbd8e08892dfd9e0cddc7"} build_url:https://queue.taskcluster.net/v1/task/HwlF6_m0T2ikaij7HgfVTw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/HwlF6_m0T2ikaij7HgfVTw/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/afe7d5d7f28a34e2dd74fe6992f2eee1b5b7352cd7811f8be8b665dde283e4a5d42577cc27cfda1c9c0249731fdc06dfb95a64357002c9523407f0cd56c25478", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e75e4d64b5e7900765317d0c822910f2faa019102bc71910e9ab2e7c32df49b8e5ada6f4c3764162e1efd793f855d682daa797e75c2fbd8e08892dfd9e0cddc7"}' ========= master_lag: 105.58 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 mins, 45 secs) (at 2016-03-23 03:05:49.611832) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 29 secs) (at 2016-03-23 03:05:49.612172) ========= 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.v75AYWRJzm/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.qo5Bb8FBCH/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.005434 ========= master_lag: 29.61 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 29 secs) (at 2016-03-23 03:06:19.232352) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-03-23 03:06:19.232750) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-03-23 03:06:23.405355) ========= ========= Total master_lag: 391.97 =========