builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0258 starttime: 1467551599.53 results: success (0) buildid: 20160703030210 builduid: 2d93c6603d9d4918a13ffe85e2a3012e revision: 39dffbba764210b25bfc1e749b4f16db77fa0d46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 06:13:19.531148) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 06:13:19.531902) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 06:13:19.532213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 06:13:19.666818) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 06:13:19.667123) ========= 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.h1D7JpdjHW/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.bSb3jhBWtU/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-07-03 06:13:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.26M=0.001s 2016-07-03 06:13:20 (8.26 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.575612 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 06:13:20.278104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 06:13:20.278448) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h1D7JpdjHW/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.bSb3jhBWtU/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.020517 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 06:13:20.331325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-03 06:13:20.331687) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 39dffbba764210b25bfc1e749b4f16db77fa0d46 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 39dffbba764210b25bfc1e749b4f16db77fa0d46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h1D7JpdjHW/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.bSb3jhBWtU/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-07-03 06:13:20,416 truncating revision to first 12 chars 2016-07-03 06:13:20,416 Setting DEBUG logging. 2016-07-03 06:13:20,416 attempt 1/10 2016-07-03 06:13:20,416 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/39dffbba7642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-03 06:13:21,404 unpacking tar archive at: mozilla-central-39dffbba7642/testing/mozharness/ program finished with exit code 0 elapsedTime=1.261426 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-03 06:13:21.618602) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 06:13:21.619345) ========= script_repo_revision: 39dffbba764210b25bfc1e749b4f16db77fa0d46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 06:13:21.620324) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 06:13:21.621051) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 06:13:21.640753) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-03 06:13:21.641433) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h1D7JpdjHW/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.bSb3jhBWtU/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 06:13:21 INFO - MultiFileLogger online at 20160703 06:13:21 in /builds/slave/test 06:13:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:13:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:13:21 INFO - {'append_to_log': False, 06:13:21 INFO - 'base_work_dir': '/builds/slave/test', 06:13:21 INFO - 'blob_upload_branch': 'Firefox', 06:13:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:13:21 INFO - 'branch': 'Firefox', 06:13:21 INFO - 'buildbot_json_path': 'buildprops.json', 06:13:21 INFO - 'config_files': ('talos/mac_config.py',), 06:13:21 INFO - 'default_actions': ('clobber', 06:13:21 INFO - 'read-buildbot-config', 06:13:21 INFO - 'download-and-extract', 06:13:21 INFO - 'populate-webroot', 06:13:21 INFO - 'create-virtualenv', 06:13:21 INFO - 'install', 06:13:21 INFO - 'run-tests'), 06:13:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:13:21 INFO - 'download_minidump_stackwalk': True, 06:13:21 INFO - 'download_symbols': 'ondemand', 06:13:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:13:21 INFO - 'tooltool.py': '/tools/tooltool.py', 06:13:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:13:21 INFO - '/tools/misc-python/virtualenv.py')}, 06:13:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:13:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:13:21 INFO - 'installer_path': 'installer.exe', 06:13:21 INFO - 'log_level': 'info', 06:13:21 INFO - 'log_name': 'talos', 06:13:21 INFO - 'log_to_console': True, 06:13:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:13:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:13:21 INFO - 'opt_config_files': (), 06:13:21 INFO - 'pip_index': False, 06:13:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:13:21 INFO - 'cmd': ('bash', 06:13:21 INFO - '-c', 06:13:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:13:21 INFO - 'enabled': True, 06:13:21 INFO - 'halt_on_failure': False, 06:13:21 INFO - 'name': 'check_screen_resolution'},), 06:13:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:13:21 INFO - 'cmd': ('bash', 06:13:21 INFO - '-c', 06:13:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:13:21 INFO - 'enabled': True, 06:13:21 INFO - 'halt_on_failure': False, 06:13:21 INFO - 'name': 'check_screen_resolution'},), 06:13:21 INFO - 'run_cmd_checks_enabled': True, 06:13:21 INFO - 'sps_profile': False, 06:13:21 INFO - 'sps_profile_interval': 0, 06:13:21 INFO - 'suite': 'dromaeojs', 06:13:21 INFO - 'system_bits': '32', 06:13:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:13:21 INFO - 'title': 't-yosemite-r7-0258', 06:13:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:13:21 INFO - 'use_talos_json': True, 06:13:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:13:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:13:21 INFO - 'work_dir': 'build'} 06:13:21 INFO - ##### 06:13:21 INFO - ##### Running clobber step. 06:13:21 INFO - ##### 06:13:21 INFO - Running pre-action listener: _resource_record_pre_action 06:13:21 INFO - Running main action method: clobber 06:13:21 INFO - rmtree: /builds/slave/test/build 06:13:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:13:23 INFO - Running post-action listener: _resource_record_post_action 06:13:23 INFO - ##### 06:13:23 INFO - ##### Finished clobber step (success) 06:13:23 INFO - ##### 06:13:23 INFO - ##### 06:13:23 INFO - ##### Running read-buildbot-config step. 06:13:23 INFO - ##### 06:13:23 INFO - Running pre-action listener: _resource_record_pre_action 06:13:23 INFO - Running main action method: read_buildbot_config 06:13:23 INFO - Using buildbot properties: 06:13:23 INFO - { 06:13:23 INFO - "project": "", 06:13:23 INFO - "product": "firefox", 06:13:23 INFO - "script_repo_revision": "production", 06:13:23 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:13:23 INFO - "repository": "", 06:13:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:13:23 INFO - "buildid": "20160703030210", 06:13:23 INFO - "stage_platform": "macosx64", 06:13:23 INFO - "basedir": "/builds/slave/test", 06:13:23 INFO - "nightly_build": "True", 06:13:23 INFO - "buildnumber": 1, 06:13:23 INFO - "slavename": "t-yosemite-r7-0258", 06:13:23 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 06:13:23 INFO - "platform": "yosemite_r7", 06:13:23 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:13:23 INFO - "branch": "mozilla-central", 06:13:23 INFO - "repo_path": "mozilla-central", 06:13:23 INFO - "revision": "39dffbba764210b25bfc1e749b4f16db77fa0d46", 06:13:23 INFO - "pgo_build": "False", 06:13:23 INFO - "builduid": "2d93c6603d9d4918a13ffe85e2a3012e", 06:13:23 INFO - "slavebuilddir": "test" 06:13:23 INFO - } 06:13:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 06:13:23 INFO - Running post-action listener: _resource_record_post_action 06:13:23 INFO - ##### 06:13:23 INFO - ##### Finished read-buildbot-config step (success) 06:13:23 INFO - ##### 06:13:23 INFO - ##### 06:13:23 INFO - ##### Running download-and-extract step. 06:13:23 INFO - ##### 06:13:23 INFO - Running pre-action listener: _resource_record_pre_action 06:13:23 INFO - Running main action method: download_and_extract 06:13:23 INFO - mkdir: /builds/slave/test/build/tests 06:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:23 INFO - https://queue.taskcluster.net/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:13:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 06:13:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 06:13:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 06:13:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 06:13:25 INFO - Downloaded 1199 bytes. 06:13:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 06:13:25 INFO - Using the following test package requirements: 06:13:25 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 06:13:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 06:13:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 06:13:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'jsshell-mac.zip'], 06:13:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 06:13:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 06:13:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 06:13:25 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 06:13:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 06:13:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 06:13:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:13: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')]} 06:13:25 INFO - https://queue.taskcluster.net/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:13:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:13:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:13:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:13:26 INFO - Downloaded 18791446 bytes. 06:13:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:13:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:13:29 INFO - Return code: 0 06:13:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:13:29 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')]} 06:13:29 INFO - https://queue.taskcluster.net/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:13:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:13:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:13:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:13:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:13:32 INFO - Downloaded 18791446 bytes. 06:13:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:13:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:13:36 INFO - Return code: 0 06:13:36 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')]} 06:13:36 INFO - https://queue.taskcluster.net/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:13:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:13:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:13:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:13:37 INFO - Downloaded 14405327 bytes. 06:13:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:13:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:13:38 INFO - Return code: 0 06:13:38 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')]} 06:13:38 INFO - https://queue.taskcluster.net/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:13:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:13:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:13:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 06:13:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 06:13:42 INFO - Downloaded 112576138 bytes. 06:13:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:13:42 INFO - mkdir: /builds/slave/test/properties 06:13:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:13:42 INFO - Writing to file /builds/slave/test/properties/build_url 06:13:42 INFO - Contents: 06:13:42 INFO - build_url:https://queue.taskcluster.net/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:13:43 INFO - Running post-action listener: _resource_record_post_action 06:13:43 INFO - Running post-action listener: set_extra_try_arguments 06:13:43 INFO - ##### 06:13:43 INFO - ##### Finished download-and-extract step (success) 06:13:43 INFO - ##### 06:13:43 INFO - ##### 06:13:43 INFO - ##### Running populate-webroot step. 06:13:43 INFO - ##### 06:13:43 INFO - Running pre-action listener: _resource_record_pre_action 06:13:43 INFO - Running main action method: populate_webroot 06:13:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:13:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:13:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:13:43 INFO - '--tppagecycles', 06:13:43 INFO - '7'], 06:13:43 INFO - 'tests': ['tsvgm']}}, 06:13:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:13:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:13:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:13:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:13:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:13:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:13:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:43 INFO - 'talos_options': ['--disable-e10s'], 06:13:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:13:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:13:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:43 INFO - 'talos_options': ['--disable-e10s'], 06:13:43 INFO - 'tests': ['damp', 'tps']}, 06:13:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:43 INFO - 'tests': ['damp', 'tps']}, 06:13:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:13:43 INFO - 'tests': ['dromaeo_dom']}, 06:13:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:13:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:13:43 INFO - 'tests': ['basic_compositor_video']}, 06:13:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:13:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:13:43 INFO - 'tests': ['a11yr', 06:13:43 INFO - 'ts_paint', 06:13:43 INFO - 'tpaint', 06:13:43 INFO - 'sessionrestore', 06:13:43 INFO - 'sessionrestore_no_auto_restore', 06:13:43 INFO - 'tabpaint']}, 06:13:43 INFO - 'other-e10s': {'tests': ['a11yr', 06:13:43 INFO - 'ts_paint', 06:13:43 INFO - 'tpaint', 06:13:43 INFO - 'sessionrestore', 06:13:43 INFO - 'sessionrestore_no_auto_restore', 06:13:43 INFO - 'tabpaint']}, 06:13:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:13:43 INFO - 'ts_paint', 06:13:43 INFO - 'tpaint', 06:13:43 INFO - 'sessionrestore', 06:13:43 INFO - 'sessionrestore_no_auto_restore', 06:13:43 INFO - 'tabpaint']}, 06:13:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:13:43 INFO - 'ts_paint', 06:13:43 INFO - 'tpaint', 06:13:43 INFO - 'sessionrestore', 06:13:43 INFO - 'sessionrestore_no_auto_restore', 06:13:43 INFO - 'tabpaint']}, 06:13:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:13:43 INFO - 'tests': ['a11yr', 06:13:43 INFO - 'ts_paint', 06:13:43 INFO - 'tpaint', 06:13:43 INFO - 'sessionrestore', 06:13:43 INFO - 'sessionrestore_no_auto_restore', 06:13:43 INFO - 'tabpaint']}, 06:13:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:13:43 INFO - 'tests': ['a11yr', 06:13:43 INFO - 'ts_paint', 06:13:43 INFO - 'tpaint', 06:13:43 INFO - 'sessionrestore', 06:13:43 INFO - 'sessionrestore_no_auto_restore', 06:13:43 INFO - 'tabpaint']}, 06:13:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:13:43 INFO - 'tests': ['tsvgx', 06:13:43 INFO - 'tsvgr_opacity', 06:13:43 INFO - 'tart', 06:13:43 INFO - 'tscrollx', 06:13:43 INFO - 'cart']}, 06:13:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:13:43 INFO - 'tsvgr_opacity', 06:13:43 INFO - 'tart', 06:13:43 INFO - 'tscrollx', 06:13:43 INFO - 'cart']}, 06:13:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:43 INFO - 'talos_options': ['--disable-e10s'], 06:13:43 INFO - 'tests': ['tp5o']}, 06:13:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:43 INFO - 'tests': ['tp5o']}, 06:13:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:43 INFO - 'talos_options': ['--disable-e10s', 06:13:43 INFO - '--xperf_path', 06:13:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:13:43 INFO - 'tests': ['tp5n']}, 06:13:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:43 INFO - 'talos_options': ['--xperf_path', 06:13:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:13:43 INFO - 'tests': ['tp5n']}}, 06:13:43 INFO - 'talos.zip': {'path': '', 06:13:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:13:43 INFO - Running post-action listener: _resource_record_post_action 06:13:43 INFO - ##### 06:13:43 INFO - ##### Finished populate-webroot step (success) 06:13:43 INFO - ##### 06:13:43 INFO - ##### 06:13:43 INFO - ##### Running create-virtualenv step. 06:13:43 INFO - ##### 06:13:43 INFO - Running pre-action listener: _resource_record_pre_action 06:13:43 INFO - Running main action method: create_virtualenv 06:13:43 INFO - Creating virtualenv /builds/slave/test/build/venv 06:13:43 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 06:13:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:13:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:13:43 INFO - Using real prefix '/tools/python27' 06:13:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:13:44 INFO - Installing distribute.............................................................................................................................................................................................done. 06:13:46 INFO - Installing pip.................done. 06:13:46 INFO - Return code: 0 06:13:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8be07018a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1abd30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a3b20>, '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.h1D7JpdjHW/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.bSb3jhBWtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 06:13:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:13:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1D7JpdjHW/Render', 06:13:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:46 INFO - 'HOME': '/Users/cltbld', 06:13:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:46 INFO - 'LOGNAME': 'cltbld', 06:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:46 INFO - 'MOZ_NO_REMOTE': '1', 06:13:46 INFO - 'NO_EM_RESTART': '1', 06:13:46 INFO - 'PAGER': '/bin/cat', 06:13:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:46 INFO - 'PWD': '/builds/slave/test', 06:13:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:46 INFO - 'SHELL': '/bin/bash', 06:13:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bSb3jhBWtU/Listeners', 06:13:46 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 06:13:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:46 INFO - 'USER': 'cltbld', 06:13:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:46 INFO - 'XPC_FLAGS': '0x0', 06:13:46 INFO - 'XPC_SERVICE_NAME': '0', 06:13:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:47 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 06:13:47 INFO - Cleaning up... 06:13:47 INFO - Return code: 0 06:13:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:47 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8be07018a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1abd30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a3b20>, '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.h1D7JpdjHW/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.bSb3jhBWtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 06:13:47 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>=3.1.1'] in /builds/slave/test/build 06:13:47 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>=3.1.1 06:13:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1D7JpdjHW/Render', 06:13:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:47 INFO - 'HOME': '/Users/cltbld', 06:13:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:47 INFO - 'LOGNAME': 'cltbld', 06:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:47 INFO - 'MOZ_NO_REMOTE': '1', 06:13:47 INFO - 'NO_EM_RESTART': '1', 06:13:47 INFO - 'PAGER': '/bin/cat', 06:13:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:47 INFO - 'PWD': '/builds/slave/test', 06:13:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:47 INFO - 'SHELL': '/bin/bash', 06:13:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bSb3jhBWtU/Listeners', 06:13:47 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 06:13:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:47 INFO - 'USER': 'cltbld', 06:13:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:47 INFO - 'XPC_FLAGS': '0x0', 06:13:47 INFO - 'XPC_SERVICE_NAME': '0', 06:13:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:47 INFO - Downloading/unpacking psutil>=3.1.1 06:13:47 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 06:13:47 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 06:13:47 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 06:13:47 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 06:13:47 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 06:13:47 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 06:13:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:13:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:13:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:13:50 INFO - Installing collected packages: psutil 06:13:50 INFO - Running setup.py install for psutil 06:13:50 INFO - building 'psutil._psutil_osx' extension 06:13:50 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 06:13:50 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 06:13:50 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 06:13:50 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 06:13:50 INFO - building 'psutil._psutil_posix' extension 06:13:50 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 06:13:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:13:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:13:50 INFO - ^ 06:13:51 INFO - 1 warning generated. 06:13:51 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 06:13:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:13:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:13:51 INFO - Successfully installed psutil 06:13:51 INFO - Cleaning up... 06:13:51 INFO - Return code: 0 06:13:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:13:51 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')]} 06:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:51 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')]} 06:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:51 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8be07018a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1abd30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a3b20>, '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.h1D7JpdjHW/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.bSb3jhBWtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 06:13:51 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.3'] in /builds/slave/test/build 06:13:51 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.3 06:13:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1D7JpdjHW/Render', 06:13:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:51 INFO - 'HOME': '/Users/cltbld', 06:13:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:51 INFO - 'LOGNAME': 'cltbld', 06:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:51 INFO - 'MOZ_NO_REMOTE': '1', 06:13:51 INFO - 'NO_EM_RESTART': '1', 06:13:51 INFO - 'PAGER': '/bin/cat', 06:13:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:51 INFO - 'PWD': '/builds/slave/test', 06:13:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:51 INFO - 'SHELL': '/bin/bash', 06:13:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bSb3jhBWtU/Listeners', 06:13:51 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 06:13:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:51 INFO - 'USER': 'cltbld', 06:13:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:51 INFO - 'XPC_FLAGS': '0x0', 06:13:51 INFO - 'XPC_SERVICE_NAME': '0', 06:13:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:13:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:13:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:13:53 INFO - Installing collected packages: mozsystemmonitor 06:13:53 INFO - Running setup.py install for mozsystemmonitor 06:13:54 INFO - Successfully installed mozsystemmonitor 06:13:54 INFO - Cleaning up... 06:13:54 INFO - Return code: 0 06:13:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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')]} 06:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:54 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8be07018a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1abd30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a3b20>, '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.h1D7JpdjHW/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.bSb3jhBWtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 06:13:54 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==2.5.1'] in /builds/slave/test/build 06:13:54 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==2.5.1 06:13:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1D7JpdjHW/Render', 06:13:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:54 INFO - 'HOME': '/Users/cltbld', 06:13:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:54 INFO - 'LOGNAME': 'cltbld', 06:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:54 INFO - 'MOZ_NO_REMOTE': '1', 06:13:54 INFO - 'NO_EM_RESTART': '1', 06:13:54 INFO - 'PAGER': '/bin/cat', 06:13:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:54 INFO - 'PWD': '/builds/slave/test', 06:13:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:54 INFO - 'SHELL': '/bin/bash', 06:13:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bSb3jhBWtU/Listeners', 06:13:54 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 06:13:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:54 INFO - 'USER': 'cltbld', 06:13:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:54 INFO - 'XPC_FLAGS': '0x0', 06:13:54 INFO - 'XPC_SERVICE_NAME': '0', 06:13:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:54 INFO - Downloading/unpacking jsonschema==2.5.1 06:13:54 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 06:13:54 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 06:13:54 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 06:13:54 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 06:13:54 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 06:13:54 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 06:13:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:13:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:57 INFO - Downloading functools32-3.2.3-2.tar.gz 06:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:13:57 INFO - warning: no files found matching '*.txt' 06:13:57 INFO - no previously-included directories found matching 'build' 06:13:57 INFO - no previously-included directories found matching 'dist' 06:13:57 INFO - no previously-included directories found matching '.git*' 06:13:57 INFO - Installing collected packages: jsonschema, functools32 06:13:57 INFO - Running setup.py install for functools32 06:13:57 INFO - warning: no files found matching '*.txt' 06:13:57 INFO - no previously-included directories found matching 'build' 06:13:57 INFO - no previously-included directories found matching 'dist' 06:13:57 INFO - no previously-included directories found matching '.git*' 06:13:57 INFO - Successfully installed jsonschema functools32 06:13:57 INFO - Cleaning up... 06:13:57 INFO - Return code: 0 06:13:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8be07018a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1abd30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a3b20>, '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.h1D7JpdjHW/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.bSb3jhBWtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 06:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:13:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1D7JpdjHW/Render', 06:13:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:57 INFO - 'HOME': '/Users/cltbld', 06:13:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:57 INFO - 'LOGNAME': 'cltbld', 06:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:57 INFO - 'MOZ_NO_REMOTE': '1', 06:13:57 INFO - 'NO_EM_RESTART': '1', 06:13:57 INFO - 'PAGER': '/bin/cat', 06:13:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:57 INFO - 'PWD': '/builds/slave/test', 06:13:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:57 INFO - 'SHELL': '/bin/bash', 06:13:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bSb3jhBWtU/Listeners', 06:13:57 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 06:13:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:57 INFO - 'USER': 'cltbld', 06:13:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:57 INFO - 'XPC_FLAGS': '0x0', 06:13:57 INFO - 'XPC_SERVICE_NAME': '0', 06:13:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:57 INFO - Downloading/unpacking blobuploader==1.2.4 06:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:00 INFO - Downloading blobuploader-1.2.4.tar.gz 06:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:14:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:14:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:14:01 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 06:14:01 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 06:14:01 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 06:14:01 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 06:14:01 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 06:14:01 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 06:14:01 INFO - Downloading docopt-0.6.1.tar.gz 06:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:14:01 INFO - Installing collected packages: blobuploader, requests, docopt 06:14:01 INFO - Running setup.py install for blobuploader 06:14:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:14:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:14:01 INFO - Running setup.py install for requests 06:14:02 INFO - Running setup.py install for docopt 06:14:02 INFO - Successfully installed blobuploader requests docopt 06:14:02 INFO - Cleaning up... 06:14:02 INFO - Return code: 0 06:14:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:02 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 0x10a247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8be07018a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1abd30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a3b20>, '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.h1D7JpdjHW/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.bSb3jhBWtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 06:14:02 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 06:14:02 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 06:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1D7JpdjHW/Render', 06:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:02 INFO - 'HOME': '/Users/cltbld', 06:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:02 INFO - 'LOGNAME': 'cltbld', 06:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:02 INFO - 'MOZ_NO_REMOTE': '1', 06:14:02 INFO - 'NO_EM_RESTART': '1', 06:14:02 INFO - 'PAGER': '/bin/cat', 06:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:02 INFO - 'PWD': '/builds/slave/test', 06:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:02 INFO - 'SHELL': '/bin/bash', 06:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bSb3jhBWtU/Listeners', 06:14:02 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 06:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:02 INFO - 'USER': 'cltbld', 06:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:02 INFO - 'XPC_FLAGS': '0x0', 06:14:02 INFO - 'XPC_SERVICE_NAME': '0', 06:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:02 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-cvjuaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:02 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-oD52z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:03 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-7b7zPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:03 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-oYME5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:03 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-LhfhV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:03 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-jEJlwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:03 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Px92_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:03 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Iwj0JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:03 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-nufzj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:03 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-ODUvIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:03 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-yt3U08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:03 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-sp88kJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:04 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-_dDnQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:04 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-ThHVdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:04 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-SAYbLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:04 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-hWtUev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:04 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-SQ_WQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:14:04 INFO - Running setup.py install for manifestparser 06:14:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:14:04 INFO - Running setup.py install for mozcrash 06:14:04 INFO - Running setup.py install for mozdebug 06:14:04 INFO - Running setup.py install for mozdevice 06:14:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:14:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:14:05 INFO - Running setup.py install for mozfile 06:14:05 INFO - Running setup.py install for mozhttpd 06:14:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:14:05 INFO - Running setup.py install for mozinfo 06:14:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:14:05 INFO - Running setup.py install for mozInstall 06:14:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:14:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:14:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:14:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:14:05 INFO - Running setup.py install for mozleak 06:14:05 INFO - Running setup.py install for mozlog 06:14:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:14:06 INFO - Running setup.py install for moznetwork 06:14:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:14:06 INFO - Running setup.py install for mozprocess 06:14:06 INFO - Running setup.py install for mozprofile 06:14:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:14:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:14:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:14:06 INFO - Running setup.py install for mozrunner 06:14:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:14:06 INFO - Running setup.py install for mozscreenshot 06:14:06 INFO - Running setup.py install for moztest 06:14:06 INFO - Running setup.py install for mozversion 06:14:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:14:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:14:07 INFO - Cleaning up... 06:14:07 INFO - Return code: 0 06:14:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:07 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 0x10a247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8be07018a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1abd30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a3b20>, '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.h1D7JpdjHW/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.bSb3jhBWtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 06:14:07 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 06:14:07 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 06:14:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1D7JpdjHW/Render', 06:14:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:07 INFO - 'HOME': '/Users/cltbld', 06:14:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:07 INFO - 'LOGNAME': 'cltbld', 06:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:07 INFO - 'MOZ_NO_REMOTE': '1', 06:14:07 INFO - 'NO_EM_RESTART': '1', 06:14:07 INFO - 'PAGER': '/bin/cat', 06:14:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:07 INFO - 'PWD': '/builds/slave/test', 06:14:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:07 INFO - 'SHELL': '/bin/bash', 06:14:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bSb3jhBWtU/Listeners', 06:14:07 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 06:14:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:07 INFO - 'USER': 'cltbld', 06:14:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:07 INFO - 'XPC_FLAGS': '0x0', 06:14:07 INFO - 'XPC_SERVICE_NAME': '0', 06:14:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:07 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-jp5Rxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:07 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)) 06:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:07 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-oqunar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:07 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)) 06:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:07 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-I8xT9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:07 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)) 06:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:07 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-imLZEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:07 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)) 06:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:07 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-xrErtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:07 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)) 06:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:07 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Os3ubF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:08 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)) 06:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:08 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-oeScZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:08 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)) 06:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:08 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Mac5Fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:08 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)) 06:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:08 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Ra_LBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:08 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)) 06:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:08 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-_7ppao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 06:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:08 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-p4_2oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:08 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)) 06:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:08 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-7Lklw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:08 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)) 06:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:08 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-7SWa_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:08 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)) 06:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:08 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-pE6DSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:08 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)) 06:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:08 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-haATdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:09 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)) 06:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:09 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-leQxgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:09 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)) 06:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:09 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-RyG79k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:09 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)) 06:14:09 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)) 06:14:09 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)) 06:14:09 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)) 06:14:09 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)) 06:14:09 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)) 06:14:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14:11 INFO - Downloading blessings-1.6.tar.gz 06:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:14:11 INFO - Installing collected packages: blessings 06:14:11 INFO - Running setup.py install for blessings 06:14:11 INFO - Successfully installed blessings 06:14:11 INFO - Cleaning up... 06:14:12 INFO - Return code: 0 06:14:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:14:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:12 INFO - Reading from file tmpfile_stdout 06:14:12 INFO - Current package versions: 06:14:12 INFO - blessings == 1.6 06:14:12 INFO - blobuploader == 1.2.4 06:14:12 INFO - docopt == 0.6.1 06:14:12 INFO - functools32 == 3.2.3-2 06:14:12 INFO - jsonschema == 2.5.1 06:14:12 INFO - manifestparser == 1.1 06:14:12 INFO - mozInstall == 1.12 06:14:12 INFO - mozcrash == 0.17 06:14:12 INFO - mozdebug == 0.1 06:14:12 INFO - mozdevice == 0.48 06:14:12 INFO - mozfile == 1.2 06:14:12 INFO - mozhttpd == 0.7 06:14:12 INFO - mozinfo == 0.9 06:14:12 INFO - mozleak == 0.1 06:14:12 INFO - mozlog == 3.2 06:14:12 INFO - moznetwork == 0.27 06:14:12 INFO - mozprocess == 0.22 06:14:12 INFO - mozprofile == 0.28 06:14:12 INFO - mozrunner == 6.11 06:14:12 INFO - mozscreenshot == 0.1 06:14:12 INFO - mozsystemmonitor == 0.3 06:14:12 INFO - moztest == 0.7 06:14:12 INFO - mozversion == 1.4 06:14:12 INFO - psutil == 3.1.1 06:14:12 INFO - requests == 1.2.3 06:14:12 INFO - wsgiref == 0.1.2 06:14:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:12 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 0x10a247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8be07018a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1abd30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a3b20>, '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.h1D7JpdjHW/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.bSb3jhBWtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 06:14:12 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 06:14:12 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 06:14:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1D7JpdjHW/Render', 06:14:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:12 INFO - 'HOME': '/Users/cltbld', 06:14:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:12 INFO - 'LOGNAME': 'cltbld', 06:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:12 INFO - 'MOZ_NO_REMOTE': '1', 06:14:12 INFO - 'NO_EM_RESTART': '1', 06:14:12 INFO - 'PAGER': '/bin/cat', 06:14:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:12 INFO - 'PWD': '/builds/slave/test', 06:14:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:12 INFO - 'SHELL': '/bin/bash', 06:14:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bSb3jhBWtU/Listeners', 06:14:12 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 06:14:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:12 INFO - 'USER': 'cltbld', 06:14:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:12 INFO - 'XPC_FLAGS': '0x0', 06:14:12 INFO - 'XPC_SERVICE_NAME': '0', 06:14:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:12 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)) 06:14:12 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)) 06:14:12 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)) 06:14:12 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)) 06:14:12 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)) 06:14:12 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)) 06:14:12 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)) 06:14:12 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)) 06:14:12 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)) 06:14:12 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)) 06:14:12 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)) 06:14:12 INFO - Cleaning up... 06:14:12 INFO - Return code: 0 06:14:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:12 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 0x10a247a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8be07018a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1abd30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a3b20>, '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.h1D7JpdjHW/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.bSb3jhBWtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 06:14:12 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 06:14:12 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 06:14:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1D7JpdjHW/Render', 06:14:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:12 INFO - 'HOME': '/Users/cltbld', 06:14:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:12 INFO - 'LOGNAME': 'cltbld', 06:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:12 INFO - 'MOZ_NO_REMOTE': '1', 06:14:12 INFO - 'NO_EM_RESTART': '1', 06:14:12 INFO - 'PAGER': '/bin/cat', 06:14:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:12 INFO - 'PWD': '/builds/slave/test', 06:14:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:12 INFO - 'SHELL': '/bin/bash', 06:14:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bSb3jhBWtU/Listeners', 06:14:12 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 06:14:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:12 INFO - 'USER': 'cltbld', 06:14:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:12 INFO - 'XPC_FLAGS': '0x0', 06:14:12 INFO - 'XPC_SERVICE_NAME': '0', 06:14:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:14:12 INFO - Cleaning up... 06:14:12 INFO - Return code: 0 06:14:12 INFO - Running post-action listener: _resource_record_post_action 06:14:12 INFO - Running post-action listener: _start_resource_monitoring 06:14:12 INFO - Starting resource monitoring. 06:14:12 INFO - ##### 06:14:12 INFO - ##### Finished create-virtualenv step (success) 06:14:12 INFO - ##### 06:14:12 INFO - ##### 06:14:12 INFO - ##### Running install step. 06:14:12 INFO - ##### 06:14:12 INFO - Running pre-action listener: _resource_record_pre_action 06:14:12 INFO - Running main action method: install 06:14:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:13 INFO - Reading from file tmpfile_stdout 06:14:13 INFO - Detecting whether we're running mozinstall >=1.0... 06:14:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:14:13 INFO - Reading from file tmpfile_stdout 06:14:13 INFO - Output received: 06:14:13 INFO - Usage: mozinstall [options] installer 06:14:13 INFO - Options: 06:14:13 INFO - -h, --help show this help message and exit 06:14:13 INFO - -d DEST, --destination=DEST 06:14:13 INFO - Directory to install application into. [default: 06:14:13 INFO - "/builds/slave/test"] 06:14:13 INFO - --app=APP Application being installed. [default: firefox] 06:14:13 INFO - mkdir: /builds/slave/test/build/application 06:14:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:14:48 INFO - Reading from file tmpfile_stdout 06:14:48 INFO - Output received: 06:14:48 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 06:14:48 INFO - Running post-action listener: _resource_record_post_action 06:14:48 INFO - ##### 06:14:48 INFO - ##### Finished install step (success) 06:14:48 INFO - ##### 06:14:48 INFO - ##### 06:14:48 INFO - ##### Running run-tests step. 06:14:48 INFO - ##### 06:14:48 INFO - Running pre-action listener: _resource_record_pre_action 06:14:48 INFO - Running main action method: run_tests 06:14:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:14:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:14:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:14:48 INFO - 2016-07-03 06:14:48.147 screenresolution[3004:25662] starting screenresolution argv=screenresolution get 06:14:48 INFO - 2016-07-03 06:14:48.150 screenresolution[3004:25662] Display 0: 1600x1200x32@60 06:14:48 INFO - 2016-07-03 06:14:48.156 screenresolution[3005:25664] starting screenresolution argv=screenresolution list 06:14:48 INFO - Available Modes on Display 0 06:14:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:14:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:14:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:14:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:14:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:14:48 INFO - Intel Iris: 06:14:48 INFO - Chipset Model: Intel Iris 06:14:48 INFO - Type: GPU 06:14:48 INFO - Bus: Built-In 06:14:48 INFO - VRAM (Dynamic, Max): 1536 MB 06:14:48 INFO - Vendor: Intel (0x8086) 06:14:48 INFO - Device ID: 0x0a2e 06:14:48 INFO - Revision ID: 0x0009 06:14:48 INFO - Displays: 06:14:48 INFO - Display: 06:14:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:14:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:14:48 INFO - Display Serial Number: 1600x1200 60 06:14:48 INFO - Main Display: Yes 06:14:48 INFO - Mirror: Off 06:14:48 INFO - Online: Yes 06:14:48 INFO - Rotation: Supported 06:14:48 INFO - Return code: 0 06:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:14:48 INFO - Python 2.7.3 06:14:48 INFO - Return code: 0 06:14:48 INFO - grabbing minidump binary from tooltool 06:14:48 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')]} 06:14:48 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1abd30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:14:48 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 06:14:48 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 06:14:48 INFO - Calling ['/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'] with output_timeout 600 06:14:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:14:48 INFO - Return code: 0 06:14:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:14:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:14:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:14:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:14:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--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 06:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0258 --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 06:14:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1D7JpdjHW/Render', 06:14:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:48 INFO - 'HOME': '/Users/cltbld', 06:14:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:48 INFO - 'LOGNAME': 'cltbld', 06:14:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:14:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:48 INFO - 'MOZ_NO_REMOTE': '1', 06:14:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:14:48 INFO - 'NO_EM_RESTART': '1', 06:14:48 INFO - 'PAGER': '/bin/cat', 06:14:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:48 INFO - 'PWD': '/builds/slave/test', 06:14:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:14:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:48 INFO - 'SHELL': '/bin/bash', 06:14:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bSb3jhBWtU/Listeners', 06:14:48 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 06:14:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:48 INFO - 'USER': 'cltbld', 06:14:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:48 INFO - 'XPC_FLAGS': '0x0', 06:14:48 INFO - 'XPC_SERVICE_NAME': '0', 06:14:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--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 06:14:48 INFO - mozversion application_buildid: 20160703030210 06:14:48 INFO - mozversion application_changeset: 39dffbba764210b25bfc1e749b4f16db77fa0d46 06:14:48 INFO - mozversion application_display_name: Nightly 06:14:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:14:48 INFO - mozversion application_name: Firefox 06:14:48 INFO - mozversion application_remotingname: firefox 06:14:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:14:48 INFO - mozversion application_vendor: Mozilla 06:14:48 INFO - mozversion application_version: 50.0a1 06:14:48 INFO - mozversion platform_buildid: 20160703030210 06:14:48 INFO - mozversion platform_changeset: 39dffbba764210b25bfc1e749b4f16db77fa0d46 06:14:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:14:48 INFO - mozversion platform_version: 50.0a1 06:14:48 INFO - using testdate: 1467551688 06:14:48 INFO - actual date: 1467551688 06:14:48 INFO - starting webserver on 'localhost:54484' 06:14:48 INFO - SUITE-START | Running 2 tests 06:14:48 INFO - TEST-START | dromaeo_css 06:14:48 INFO - operating with platform_type : mac_ 06:14:48 INFO - Initialising browser for dromaeo_css test... 06:14:48 INFO - TEST-INFO | started process 3015 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpvT3Xkh/profile http://localhost:54484/getInfo.html) 06:14:51 INFO - PROCESS | 3015 | __metrics Screen width/height:1600/1200 06:14:51 INFO - PROCESS | 3015 | colorDepth:24 06:14:51 INFO - PROCESS | 3015 | Browser inner width/height: 1024/689 06:14:51 INFO - PROCESS | 3015 | __metrics 06:14:51 INFO - PROCESS | 3015 | 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" 06:14:51 INFO - PROCESS | 3015 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:14:51 INFO - TEST-INFO | 3015: exit 0 06:14:51 INFO - Browser initialized. 06:14:51 INFO - Running cycle 1/1 for dromaeo_css test... 06:14:51 INFO - TEST-INFO | started process 3018 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpvT3Xkh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:04 INFO - PROCESS | 3018 | RSS: Main: 243687424 06:15:04 INFO - PROCESS | 3018 | 06:15:55 INFO - PROCESS | 3018 | 1467551755504 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] 06:18:06 INFO - PROCESS | 3018 | Cycle 1(1): loaded http://localhost:54484/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54484/tests/dromaeo/cssquery-ext.html) 06:18:08 INFO - PROCESS | 3018 | RSS: Main: 370761728 06:18:08 INFO - PROCESS | 3018 | 06:21:11 INFO - PROCESS | 3018 | Cycle 1(1): loaded http://localhost:54484/tests/dromaeo/cssquery-ext.html (next: http://localhost:54484/tests/dromaeo/cssquery-jquery.html) 06:21:11 INFO - PROCESS | 3018 | RSS: Main: 374689792 06:21:11 INFO - PROCESS | 3018 | 06:24:14 INFO - PROCESS | 3018 | Cycle 1(1): loaded http://localhost:54484/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54484/tests/dromaeo/cssquery-mootools.html) 06:24:14 INFO - PROCESS | 3018 | RSS: Main: 371097600 06:24:14 INFO - PROCESS | 3018 | 06:27:16 INFO - PROCESS | 3018 | Cycle 1(1): loaded http://localhost:54484/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54484/tests/dromaeo/cssquery-prototype.html) 06:27:17 INFO - PROCESS | 3018 | RSS: Main: 369909760 06:27:17 INFO - PROCESS | 3018 | 06:30:20 INFO - PROCESS | 3018 | Cycle 1(1): loaded http://localhost:54484/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54484/tests/dromaeo/cssquery-yui.html) 06:30:21 INFO - PROCESS | 3018 | RSS: Main: 333066240 06:30:21 INFO - PROCESS | 3018 | 06:33:24 INFO - PROCESS | 3018 | Cycle 1(1): loaded http://localhost:54484/tests/dromaeo/cssquery-yui.html (next: http://localhost:54484/tests/dromaeo/cssquery-dojo.html) 06:33:24 INFO - PROCESS | 3018 | RSS: Main: 402968576 06:33:24 INFO - PROCESS | 3018 | 06:33:24 INFO - PROCESS | 3018 | __start_tp_report 06:33:24 INFO - PROCESS | 3018 | _x_x_mozilla_page_load 06:33:24 INFO - PROCESS | 3018 | _x_x_mozilla_page_load_details 06:33:24 INFO - PROCESS | 3018 | |i|pagename|runs| 06:33:24 INFO - PROCESS | 3018 | |0;dojo.html;3367.343368043231;3389.745794056198;3423.503591979162;3425.811580363079;3467.0812234757777;5721.799737009205;5798.507126894208;5835.824925252244;5873.618214816034;5881.764729410824;5825.388334224909;5841.941580584193;5925.407459254073;5953.821385358436;5965.88068238635;5168.948310516885;5169.405518365398;5223.973880130594;5255.894882102375;5354.303940487731;5333.893322133555;5359.705216213107;5367.194920761878;5379.193121031857;5420.159875219348;5168.250603662466;5206.713630750307;5224.73876306187;5279.366476022902;5311.654742441729;4642.839290177456;5048.293238946514;5261.026710058652;5269.314989051399;5269.894602107936;5187.118189907687;5221.530062294374;5235.319408476912;5251.212318152269;5262.394824595144;5754.280714910637;5778.479936805707;5781.219535362714;5809.070548712186;5820.476157145835;6283.497320214417;6330.050492426127;6343.777967771152;6351.364863513611;6355;6124.808163753419;6266.060090986343;6294.842628934268;6299;6316.336784637639;5899.581381192614;5987.371326010793;5990.7903223386975;6001.489873360726;6001.7599296027665;5405.21624364465;6312.368763123651;6318.115463835067;6320.747170113236;6330.335314791972;6107;6177.907331390033;6238.064290356483;6244.2819075805955;6285.088662143963;6284.371562843679;6308.148399965946;6315.431611155018;6316.526260530479;6328.11406403104;6147.262328520516;6336.746530138835;6343.746250149942;6345.365463453618;6347.270063942706;6245.781397651061;6296.527760417987;6326.873462530723;6329.145565348711;6367.108604795332;5006.048850718352;5006.786156241227;5009.273655319958;5010.549050585465;5021.196608542616;4457.175422546839;4458.331250312414;4491.124230774967;4502.054568540643;4537.319402089713;5719.571032172604;5782.421757824268;5813.709314534256;5813.79651712188;5826.271716035496;6255.437010669061;6331.05034244867;6340.778072767431;6341.270753863365;6350.142730731292;5837.9124313135335;5871.089981052944;5889.263842019747;5900.76396944126;5951.702414879239;5526.806561770319;5547.944520554743;5553.222548843084;5553.666779993213;5562.860928476821;6205.937940620716;6250.656213908279;6360.491160707133;6365.586236894587;6369.968150159127;6253.499720022478;6285.2457705075685;6299.748010079546;6302.527310451826;6303.212098487689;6260.655663938345;6311.274203466476;6318.589291696025;6330.556861019869;6345.079963405373;6133.059244992972;6185.257769067741;6216.2540495140875;6324.051392291193;6326.9683651581445;6281.277653069956;6284.434400903758;6301.905471418024;6312.842178945563;6337.683115844097;6229.0967809668255;6229.937700622936;6231.439170474498;6233.625982440886;6249.968750156402;6040.365761595145;6096.345267793883;6107.583301036431;6163.137160797402;6193.6903154841175;6074.3318234994995;6077.20996270482;6093.238345206849;6098.115773212948;6100.969495152496;5115.386153661584;6216.316205217513;6229.345918678474;6240.656763878031;6240.719167637377;5885.323187833283;5994.970025149846;6048.667323297261;6100.633961962297;6120.571559990936 06:33:24 INFO - PROCESS | 3018 | |1;ext.html;448.1910152175322;476.61156157731466;496.4167103653207;524.493863421798;542.6906663201975;30343.696563034362;32398.838005809997;32809.68761249553;41066.79466602667;41688.58311416885;42332;43568.34647480283;43695.56304436955;43719;43769.562304376945;9622.903770962288;9777.364471309342;9810.852837207447;9811.264155188353;9811.901880981206;8672;8873.20141187293;8875.911240887574;8918.197362237397;8935.06181850906;11655.533778648887;11924.582639607615;11932.031214849583;12129.696757581087;12149.149559530837;11902.523899044028;11928.284302941851;11998.280103193836;12003.399830008508;12015.038796896315;8605.698800542013;8813.647454101829;8818.382713210078;11694.532218711242;11780.764384712344;32439.675603244137;39849;40149.99625009369;40204.59795402038;42819;3468.3756923753713;3509.175343794232;3564.946525802115;3696.5379327583782;3817.1983883384523;28981.13056608305;29101.272468188254;32154.356912861847;32836.507452387996;32888.848890288726;3279.212988882675;3290.8190049547507;3321.534985102088;3376.5610470638903;3443.6384179661027;507130;507914;508720;510248;510703;51003;57487.13769293464;57828.4217157823;57924.71037644869;61982;63721.36278637247;63927.360726392144;63975;64093.679531602975;64307.35692643013;16042.117683527518;16155.434559790587;16233.83766162347;16236.350545978028;16243.106629135511;12520.31138287403;12566.685832854251;12585.433655485525;12698.555550555686;12703.809442858179;12231.510739570318;14584.1978691173;16323;16424.1787910604;16665.583360416087;6345.428911397904;6351.682415879188;6362.491000719931;6387.137736405619;6395.584287021329;910.717677519971;1025.4206373399006;1025.8922813104666;1040.7138037039874;1126.6732647532124;30364.69635303663;30521;30546.84726576353;31153.8442307787;31209;864.5288317866778;925;966.6230170233614;1117.9161562882816;1120.8935151160626;15801.446949356718;15969.520914372355;16034.919825400799;16375.918120409322;16391.83608163927;630824;643148;647916;650444;651789;58481.41518584845;59138.40861591329;59159;59193;59453.999999999134;1270.7712611729792;1301.1802564384377;1398.454602704946;1412.971740565183;1429.6140042188551;30934.381312374077;31219.687803122586;31752.682473174973;32371.838140809145;32481.35037299288;55756.163657544355;56620;56646.43353566412;56740.43259567516;56753.71623141858;586260;605543;605900;607163;607397;34549.48175777315;40362.596374035886;40792.184156316114;41026;41877.79061104675;47973;48073;48710.5128948706;49547.25679114744;49828.50171498238;39382.409263861635;39407.80296098501;39716.80141599273;40396.99007524835;40546;37202.8139859299;38620.80689596534;39551.60448395594;40284;40330.160380754496;37726.43410348902;38201;38577;38592.8422147336;38722;30969;34163.65836341605;34450;35324.11689707778;36985.630143699294;25521.74478255268;25849.353766155244;25857.612135817602;25931.092411765498;26174.60738088892 06:33:24 INFO - PROCESS | 3018 | |2;jquery.html;324.542395222736;362.15798269024515;386.19093000164645;388.18674876134486;407.20594840061887;14339.067960582568;16519.587010324733;20248.29130980416;20549.589008219828;20608.38174854753;19580.706289405636;20294;20605.896970515125;20615.793842061576;20926.37220883372;5590;5851.912221316684;6100.23747031621;6119.204503414572;6121.938780612181;6012.75948962041;6103.603265787732;6104.023356262999;6113.938860611382;6140.048292514645;5764.855878603047;5983.640981541122;6002.969985150068;6067.969660151715;6069.544784141185;5986.191864098335;6002.939970600303;6015.669138197398;6034.818955431322;6046.365131661156;5016.874578135539;5258.8685282867855;5264.236685680555;5270.183121616117;5280.788768449257;25551.872240638677;26077.60883586748;26094.34764130893;26453.470930581472;26528.867355663293;1905.637928793525;2184.1809321504434;2332.4052366646397;2772.3900741836765;3125.8124512529093;14920.477783277642;15916.124613146272;16092.275847586887;16193.838061619468;16392.67214655712;1707.7011522983428;1775.2366482412558;1865.2259312385345;1924.9422517324504;2123.9150433982622;101635.9836401634;102197.97802022034;107961;108866.45566772195;112427.31359029702;10651.254412191227;11074.612388566362;11695.766084678258;11726.648200553997;11897.226680265756;14562;14612.634684132981;14619.634509137144;14655.193964331851;14663.533646635251;8253.95873020643;8393.874091888627;8439.873401898976;8492.023417306966;8519.275861551714;6816.386525212754;8344.958275208584;8372.832543349221;8466.153384661608;8466.238038576434;4484.215262329079;4567.885802854888;4578.45058592971;4610.593768900518;4619.6073333766335;1597.560670815535;1670.189957870432;1868.9719654205198;1913.1390874106708;1946.153423260886;898.7169041751828;905.4295793649958;951.4814426137772;954.0364232125603;962.5572236771163;20389.694154587694;21479.140834366764;21563.344987767698;21586.78413215848;21660.45848853791;905.9229965452879;929.1683942871227;947.6825263536655;949.4066208619613;983.1643103362085;9950.169184863735;11133.498992545194;11220.719482012852;11280.548778048951;11311.717207069725;622596;627383;640647;645606;655523;143684;145319.54680453273;148918;150552.2472387653;153085.4691453071;990.6433683873944;1004.7337455574278;1006.2955930848435;1031.9380837149795;1033.2973577966904;19216;19349.4195174145;20456;20524.618962540146;20892.268770592957;57604.847903042544;58728;58817;59208.70395647994;59538.70230648819;77326;78896.60551697205;80446.5977670108;87457.56271218603;88669.55665221633;7071.292870712888;7339.64216619927;7345.118585769742;7617.733379331697;8116.431849770459;9123.954380228322;12436;12840.935795320964;13198.538051168163;13222.008349373644;11216.929106375457;11268.323900565993;11277.32336059839;11370.94314528422;11407.315561066363;11071.667849964513;11154;11293.686626080955;11326.263792853439;11359.659210223375;5729.054705973468;10953.56185752561;11539.307641541534;11606.651800446;11769.529218831492;7001.824954376181;7153.892691609734;7339.669714862737;7378.815529611803;7443.851122977619;8069;9892.258080644124;11025.503852326825;11265.887341126483;11364.090872730327 06:33:24 INFO - PROCESS | 3018 | |3;mootools.html;1380.2270728392095;1476.23235917323;1518.69626074785;1719.166204390871;1902.933397331093;7646.92353076469;8489.108643592426;8648.697295594655;8673.69642062528;8797.07630698777;8486.872696909551;8546.572671366437;8625.309975201984;8627.13728627137;8668.696595619138;2054.4863784053987;2353.9058437662475;2368;2379.3694670912223;2384.582698027847;2336.217367181996;2367.3134790910617;2377.2868139558063;2385.022140922222;2391.9760802392016;2337.6610391493223;2364.18435639704;2375.92872213833;2379.333786539763;2380.2621187431864;2317.084751523139;2338.871362075085;2353.999550191179;2354.3054798834387;2367.147826782374;2340.5435939991708;2344.2146880794953;2345.2143531916827;2345.7302410222874;2351.2711059571416;8459.45013574122;8627.30981521483;8631.568421578895;8699.739007829776;8701.30389568833;5139.049275883974;5324.094903866313;5331.973340133274;5333.413324534298;5334.946650533522;3619.167591453954;3636.727245456575;3670.926581468356;3711.350513660099;3714.739968202227;1096.309325125174;1098.1599076706325;1102.1898904305328;1119.5074167366333;1132.0603898764089;9822.508874556244;11317.717057073556;11426.88573114275;11463.36951467669;11472.827907581393;3678.9448158277646;4380.189664912002;4585.564371384713;4608.723476591348;4614.192516309632;8960.955195223982;8980.595873185723;8980.640774368952;8986;8986.460812351279;5193.974030129825;5198.480151984847;5203.063448579216;5204.4014938281825;5206.062908676399;3764.548254209458;4384.912301753947;4517.841875534341;4832.4684284728655;4871.878203044881;3753.436984452354;3782.5460944686815;3808;3846.769193848378;3854.845806167778;1146.0602306109076;1160.3675996581883;1161.1523587780966;1169.6724917023248;1172.1619042384737;907.9409838360485;911.4855126484741;915.4919019943862;933.7338858425317;973.109604711695;5815.563832712563;5825.359210486843;5916.704164791743;6035.818925432244;6081.665508396992;438.931965545341;445.3631307230626;451.94124763780496;460.4060761617476;468.16432667688014;3795.658390744846;3920.09837737322;4013.5585085640555;4094.877153685394;4126.051008268115;10189.439580823126;10583.947080264703;10712.678619641423;10717;10753.51609177589;10663.093637040784;10669;10673.626423075155;10676;10728.517216725266;7683.462157648911;8111.634976426075;8130.308923741548;8244.175582441827;8253.504789712637;5760.33756118035;6031.879362412815;6036.185115009594;6087.904177248138;6099.298580663103;9403.294752893424;9526.761830954281;10064.39613623185;10065.345752526062;10076.596936122472;10043.69868903934;10248.026437488426;10248.692539223835;10263;10330.018648228406;7431.071116110486;7514;7553.886691699519;7572.091349037931;7592.8861067085145;8015.519068855654;8081.797955050935;8082.878756818534;8090.878636820335;8103.918960810316;6416.550841441054;7318.560886346836;7432.851342973002;7435.4795164337975;7527.698892044257;6260.968695156495;7290.234525374972;7296;7342.265773422615;7443.106827180773;6625.370589793962;6905.585664860125;6976.267491913479;6985.755498557526;6992.265812089658;4269.889828644513;4676.158291507561;5016.724080175625;5077.714036167257;5152.175651895679;5082.949170508247;5126.897462050663;5156.458571849902;5164.9741751291;5183.688978661293 06:33:24 INFO - PROCESS | 3018 | |4;prototype.html;247.9429731161833;295.3266552260846;311.5715890650356;311.78019496255143;312.788867514428;4486.3494793254995;4977.178765503692;5219.8434046978555;5399.7860877040375;5497.312835895513;5098.09408637077;5106.131957567213;5277.947220527793;5288.312519372476;5391.649542779726;3023.8790448382147;3817.9045523861846;4062.1875624874997;4072.3484242521204;4088.5707000764787;3605.2068544920076;4062.878113656595;4072.4705788247634;4073.6780035379848;4110.732802367851;3755.6619904208615;3883.5533913599875;3898.5906479819637;4020.376841589544;4052.1085361220485;3350.8659653613827;4044.47421835161;4045.4134150548007;4049.4128351388886;4065.5527891931865;3461.3769521486124;3530.73519486037;3531.474995378291;3547.6452354764574;3549.0594992327055;4489.6408287336935;4844.59217991961;5240.292560504321;5261.710605916673;5273.8620520790455;4379.956200437987;4642.4679855647555;4678.777580649198;4679.789409476548;4686.81252749893;5411.702356370398;5572.916406253909;5631.549476041907;5663.207150998864;5703.258576385043;3301.3397320535987;3424.417848965682;3894.571597124314;3924.7056470764524;3927.7839718815453;5517.200005999108;5827.854303642401;5868.4424979626865;5878.177055212273;5935.26977590309;3464.913377165591;3786.413105968579;3866.3233934061427;3868.7485313454536;3882.76703397797;3415.79505229687;3930.253251882133;3954.940675889864;3970.4639873616693;3974.158476689181;4402.9559704402545;4561.589456948891;4606.861794146181;4640.3967484227505;4645;4518.502964673883;5523.972380138073;5595.832125036255;5635.380108188096;5660.518855897212;1102.5589764094266;1216.2216181643755;1323.5632241360329;1333.599920023989;1353.1137105196112;751.9510283154968;774.3224678406394;836.5691668790578;856.3662889461754;905.2803021597846;4986.282476050488;5269.815556455583;5302.946970530323;5306.787728490895;5339.492748188916;5245.396779370345;5775.624584402;5796.594238403271;5840.649561026352;5861.794837180678;4761.381020467317;5057.367829021372;5130.717810520383;5270.736463176826;5310.575153987672;2599.7790187833866;2605.0751983046125;2630.7237740037403;3060.8469576521084;3082.9383412331626;5251.369835619674;5676.460736230051;5713.74307148674;5940.79207227745;5994.310654274815;4936.925946110811;5925.585209035412;5951.827582932285;5966.940330596725;5969.880602387928;5888.352281249059;5910.793122240787;5987.904233518234;6020.54845886569;6062.999999999912;5120.513551212629;5420.512153906167;5618.85952851182;5729.828105156852;5776.768929242783;5037.967216720637;5602.711376383373;5626.35296940857;5641;5714.5999780015;5187.792488300426;5715.428457154251;5964.850878728066;6017.525706202008;6031.035034394476;3318.4192766265323;3599.478075679064;3854.20988697322;3871;3931.2923673739;4485.420882992357;5203.453637368173;5435.565154787529;5927.673977931255;5973.880522389615;5512.448755124616;5767.250257466502;5783.334916484658;5786.4213578643485;5794.971025144847;4484.215262329014;4699.365585645894;4976.626752993612;5484.862878428071;5618.85952851182;4625.352450656844;4654.790534426027;5298.5958720938215;5499.642523235977;5587.8882422352135;5187.559057480005;5302.973485132549;5341.011912796145;5713.543046523277;5719.685417302088;5119.616028797781;5586.608937374344;5602.607817452739;5609.831705048855;5625.774969001194 06:33:24 INFO - PROCESS | 3018 | |5;yui.html;686.7356067913853;736.4881407421844;797.9082405523367;828.1594181905365;856.6402111113332;14394.280285985698;15256.160911149882;15333.616659583502;15419.997700149483;15443.382264709413;14591.27043647816;14759.18824464654;14779.704405911902;14780.926095369508;14815.629609259773;700.3276854219955;733.7431898835391;859.1451505751786;874.7200895713374;900.9954950225273;867.3754896474528;878.8242351529688;882.496976723268;883.3683916000059;885.7032893980524;940.4263399326439;940.4921342475055;940.6566603189821;942.2226663003015;942.6512190489494;733.5525329548971;913.0869130869131;935.1350001248818;949.4872768704892;950.6910254167424;700.4396482813779;700.726716580534;701.1621112770241;702.5012241308677;702.5679207287482;14690;14734.042287251294;14744.410223591043;14750.778738318933;14753.483628072965;13893.027488075839;13953.302334883216;13973.301334933212;14021.369038393297;14154;12711.872881271162;12770.106092573524;12837.814215292154;13005.544805931842;13063.412146453433;4609.285560738091;4612.215923293048;4737.2420412734145;4794.856154315341;4803.159447096744;108956;110612.34081488784;110786.46067696583;111210.44394778056;112507.43746281216;11124;11228.214025018171;11269.887301126884;11270.380129092815;11413.97274245322;21707.240246591293;21981.23065692693;21984.560308793734;22077.448063798533;22088.779112208995;7943.841123177504;7978;8010.719624813103;8018.5990700464745;8122.3502119831455;4434.490033646172;4505.098980203972;4515.345274935116;4515.977420112944;4656.045510670305;3372.650939624121;3487.6512348764923;3491.685748282616;3492.5808902931303;3493.475978603179;658;666.4601672645076;671.5366397185926;672.5124284893413;675.4933799650262;520.6017396691534;629.2511910826103;631.5736877607596;654.8264709851893;656;9151.588178531982;9436.716898493056;9512.479193013856;9556.426614403159;9706;590.3801008940595;623.8752249550108;643.8326035230874;682.7030241844814;701.8491024429773;4565;4653.325267836145;4706.294055891643;4749.548792864673;4751.691140075953;139778.5055373624;141138;145028;145303;146194.5380546202;114451;120036;120376;122005.77994220122;122388.38805805914;98734;100344;103834.92330153355;109338.23894993351;110971.44514277538;9566.66516671913;9797.461139637388;9903.207743380657;10172.491375431051;10225.590976360862;44537.21433678173;49872;57694;59110;64224;87278;88716;88872.5556372214;90462.54768726115;91318.54340728254;11292.830607540729;11730.589429369931;11879.643610691694;12075.39623018828;12604.243745375306;12846.893392105329;14558.12651240929;15342.23288835576;15558.844411556192;16073.839261607234;12219.389030548615;13824;14074.437022518985;14494.05788623736;14603.488877889224;13095.8213760762;13997.930010349883;14006.859931400555;14589.197594132425;14935.103893766409;11476;13765.242911639956;14012.598740125906;14047.438102475786;14151.363188656329;11386.146039047271;11470.254433461798;11672.533098675958;11747;12239.20445171061;11234.494447749707;11536.884631153582;11651.650450486499;11704.882951170379;11711.238769479956 06:33:24 INFO - PROCESS | 3018 | __end_tp_report 06:33:24 INFO - PROCESS | 3018 | __start_cc_report 06:33:24 INFO - PROCESS | 3018 | _x_x_mozilla_cycle_collect,1257 06:33:24 INFO - PROCESS | 3018 | __end_cc_report 06:33:24 INFO - PROCESS | 3018 | __startTimestamp1467552804814__endTimestamp 06:33:24 INFO - PROCESS | 3018 | 06:33:24 INFO - PROCESS | 3018 | ------- Summary: start ------- 06:33:24 INFO - PROCESS | 3018 | Number of tests: 6 06:33:24 INFO - PROCESS | 3018 | 06:33:24 INFO - PROCESS | 3018 | [#0] dojo.html Cycles:165 Average:5816.27 Median:6077.21 stddev:647.11 (10.6%) stddev-sans-first:619.93 06:33:24 INFO - PROCESS | 3018 | Values: 3367.3 3389.7 3423.5 3425.8 3467.1 5721.8 5798.5 5835.8 5873.6 5881.8 5825.4 5841.9 5925.4 5953.8 5965.9 5168.9 5169.4 5224.0 5255.9 5354.3 5333.9 5359.7 5367.2 5379.2 5420.2 5168.3 5206.7 5224.7 5279.4 5311.7 4642.8 5048.3 5261.0 5269.3 5269.9 5187.1 5221.5 5235.3 5251.2 5262.4 5754.3 5778.5 5781.2 5809.1 5820.5 6283.5 6330.1 6343.8 6351.4 6355.0 6124.8 6266.1 6294.8 6299.0 6316.3 5899.6 5987.4 5990.8 6001.5 6001.8 5405.2 6312.4 6318.1 6320.7 6330.3 6107.0 6177.9 6238.1 6244.3 6285.1 6284.4 6308.1 6315.4 6316.5 6328.1 6147.3 6336.7 6343.7 6345.4 6347.3 6245.8 6296.5 6326.9 6329.1 6367.1 5006.0 5006.8 5009.3 5010.5 5021.2 4457.2 4458.3 4491.1 4502.1 4537.3 5719.6 5782.4 5813.7 5813.8 5826.3 6255.4 6331.1 6340.8 6341.3 6350.1 5837.9 5871.1 5889.3 5900.8 5951.7 5526.8 5547.9 5553.2 5553.7 5562.9 6205.9 6250.7 6360.5 6365.6 6370.0 6253.5 6285.2 6299.7 6302.5 6303.2 6260.7 6311.3 6318.6 6330.6 6345.1 6133.1 6185.3 6216.3 6324.1 6327.0 6281.3 6284.4 6301.9 6312.8 6337.7 6229.1 6229.9 6231.4 6233.6 6250.0 6040.4 6096.3 6107.6 6163.1 6193.7 6074.3 6077.2 6093.2 6098.1 6101.0 5115.4 6216.3 6229.3 6240.7 6240.7 5885.3 5995.0 6048.7 6100.6 6120.6 06:33:24 INFO - PROCESS | 3018 | 06:33:24 INFO - PROCESS | 3018 | [#1] ext.html Cycles:180 Average:72250.96 Median:39395.11 stddev:157109.12 (398.8%) stddev-sans-first:157457.35 06:33:24 INFO - PROCESS | 3018 | Values: 448.2 476.6 496.4 524.5 542.7 30343.7 32398.8 32809.7 41066.8 41688.6 42332.0 43568.3 43695.6 43719.0 43769.6 9622.9 9777.4 9810.9 9811.3 9811.9 8672.0 8873.2 8875.9 8918.2 8935.1 11655.5 11924.6 11932.0 12129.7 12149.1 11902.5 11928.3 11998.3 12003.4 12015.0 8605.7 8813.6 8818.4 11694.5 11780.8 32439.7 39849.0 40150.0 40204.6 42819.0 3468.4 3509.2 3564.9 3696.5 3817.2 28981.1 29101.3 32154.4 32836.5 32888.8 3279.2 3290.8 3321.5 3376.6 3443.6 507130.0 507914.0 508720.0 510248.0 510703.0 51003.0 57487.1 57828.4 57924.7 61982.0 63721.4 63927.4 63975.0 64093.7 64307.4 16042.1 16155.4 16233.8 16236.4 16243.1 12520.3 12566.7 12585.4 12698.6 12703.8 12231.5 14584.2 16323.0 16424.2 16665.6 6345.4 6351.7 6362.5 6387.1 6395.6 910.7 1025.4 1025.9 1040.7 1126.7 30364.7 30521.0 30546.8 31153.8 31209.0 864.5 925.0 966.6 1117.9 1120.9 15801.4 15969.5 16034.9 16375.9 16391.8 630824.0 643148.0 647916.0 650444.0 651789.0 58481.4 59138.4 59159.0 59193.0 59454.0 1270.8 1301.2 1398.5 1413.0 1429.6 30934.4 31219.7 31752.7 32371.8 32481.4 55756.2 56620.0 56646.4 56740.4 56753.7 586260.0 605543.0 605900.0 607163.0 607397.0 34549.5 40362.6 40792.2 41026.0 41877.8 47973.0 48073.0 48710.5 49547.3 49828.5 39382.4 39407.8 39716.8 40397.0 40546.0 37202.8 38620.8 39551.6 40284.0 40330.2 37726.4 38201.0 38577.0 38592.8 38722.0 30969.0 34163.7 34450.0 35324.1 36985.6 25521.7 25849.4 25857.6 25931.1 26174.6 06:33:24 INFO - PROCESS | 3018 | 06:33:24 INFO - PROCESS | 3018 | [#2] jquery.html Cycles:180 Average:36773.09 Median:26491.17 stddev:106590.67 (402.4%) stddev-sans-first:106854.55 06:33:24 INFO - PROCESS | 3018 | Values: 324.5 362.2 386.2 388.2 407.2 14339.1 16519.6 20248.3 20549.6 20608.4 19580.7 20294.0 20605.9 20615.8 20926.4 5590.0 5851.9 6100.2 6119.2 6121.9 6012.8 6103.6 6104.0 6113.9 6140.0 5764.9 5983.6 6003.0 6068.0 6069.5 5986.2 6002.9 6015.7 6034.8 6046.4 5016.9 5258.9 5264.2 5270.2 5280.8 25551.9 26077.6 26094.3 26453.5 26528.9 1905.6 2184.2 2332.4 2772.4 3125.8 14920.5 15916.1 16092.3 16193.8 16392.7 1707.7 1775.2 1865.2 1924.9 2123.9 101636.0 102198.0 107961.0 108866.5 112427.3 10651.3 11074.6 11695.8 11726.6 11897.2 14562.0 14612.6 14619.6 14655.2 14663.5 8254.0 8393.9 8439.9 8492.0 8519.3 6816.4 8345.0 8372.8 8466.2 8466.2 4484.2 4567.9 4578.5 4610.6 4619.6 1597.6 1670.2 1869.0 1913.1 1946.2 898.7 905.4 951.5 954.0 962.6 20389.7 21479.1 21563.3 21586.8 21660.5 905.9 929.2 947.7 949.4 983.2 9950.2 11133.5 11220.7 11280.5 11311.7 622596.0 627383.0 640647.0 645606.0 655523.0 143684.0 145319.5 148918.0 150552.2 153085.5 990.6 1004.7 1006.3 1031.9 1033.3 19216.0 19349.4 20456.0 20524.6 20892.3 57604.8 58728.0 58817.0 59208.7 59538.7 77326.0 78896.6 80446.6 87457.6 88669.6 7071.3 7339.6 7345.1 7617.7 8116.4 9124.0 12436.0 12840.9 13198.5 13222.0 11216.9 11268.3 11277.3 11370.9 11407.3 11071.7 11154.0 11293.7 11326.3 11359.7 5729.1 10953.6 11539.3 11606.7 11769.5 7001.8 7153.9 7339.7 7378.8 7443.9 8069.0 9892.3 11025.5 11265.9 11364.1 06:33:24 INFO - PROCESS | 3018 | 06:33:24 INFO - PROCESS | 3018 | [#3] mootools.html Cycles:180 Average:5603.81 Median:2572.16 stddev:3139.86 (122.1%) stddev-sans-first:3132.63 06:33:24 INFO - PROCESS | 3018 | Values: 1380.2 1476.2 1518.7 1719.2 1902.9 7646.9 8489.1 8648.7 8673.7 8797.1 8486.9 8546.6 8625.3 8627.1 8668.7 2054.5 2353.9 2368.0 2379.4 2384.6 2336.2 2367.3 2377.3 2385.0 2392.0 2337.7 2364.2 2375.9 2379.3 2380.3 2317.1 2338.9 2354.0 2354.3 2367.1 2340.5 2344.2 2345.2 2345.7 2351.3 8459.5 8627.3 8631.6 8699.7 8701.3 5139.0 5324.1 5332.0 5333.4 5334.9 3619.2 3636.7 3670.9 3711.4 3714.7 1096.3 1098.2 1102.2 1119.5 1132.1 9822.5 11317.7 11426.9 11463.4 11472.8 3678.9 4380.2 4585.6 4608.7 4614.2 8961.0 8980.6 8980.6 8986.0 8986.5 5194.0 5198.5 5203.1 5204.4 5206.1 3764.5 4384.9 4517.8 4832.5 4871.9 3753.4 3782.5 3808.0 3846.8 3854.8 1146.1 1160.4 1161.2 1169.7 1172.2 907.9 911.5 915.5 933.7 973.1 5815.6 5825.4 5916.7 6035.8 6081.7 438.9 445.4 451.9 460.4 468.2 3795.7 3920.1 4013.6 4094.9 4126.1 10189.4 10583.9 10712.7 10717.0 10753.5 10663.1 10669.0 10673.6 10676.0 10728.5 7683.5 8111.6 8130.3 8244.2 8253.5 5760.3 6031.9 6036.2 6087.9 6099.3 9403.3 9526.8 10064.4 10065.3 10076.6 10043.7 10248.0 10248.7 10263.0 10330.0 7431.1 7514.0 7553.9 7572.1 7592.9 8015.5 8081.8 8082.9 8090.9 8103.9 6416.6 7318.6 7432.9 7435.5 7527.7 6261.0 7290.2 7296.0 7342.3 7443.1 6625.4 6905.6 6976.3 6985.8 6992.3 4269.9 4676.2 5016.7 5077.7 5152.2 5082.9 5126.9 5156.5 5165.0 5183.7 06:33:24 INFO - PROCESS | 3018 | 06:33:24 INFO - PROCESS | 3018 | [#4] prototype.html Cycles:180 Average:4536.90 Median:5159.14 stddev:1424.59 (27.6%) stddev-sans-first:1391.74 06:33:24 INFO - PROCESS | 3018 | Values: 247.9 295.3 311.6 311.8 312.8 4486.3 4977.2 5219.8 5399.8 5497.3 5098.1 5106.1 5277.9 5288.3 5391.6 3023.9 3817.9 4062.2 4072.3 4088.6 3605.2 4062.9 4072.5 4073.7 4110.7 3755.7 3883.6 3898.6 4020.4 4052.1 3350.9 4044.5 4045.4 4049.4 4065.6 3461.4 3530.7 3531.5 3547.6 3549.1 4489.6 4844.6 5240.3 5261.7 5273.9 4380.0 4642.5 4678.8 4679.8 4686.8 5411.7 5572.9 5631.5 5663.2 5703.3 3301.3 3424.4 3894.6 3924.7 3927.8 5517.2 5827.9 5868.4 5878.2 5935.3 3464.9 3786.4 3866.3 3868.7 3882.8 3415.8 3930.3 3954.9 3970.5 3974.2 4403.0 4561.6 4606.9 4640.4 4645.0 4518.5 5524.0 5595.8 5635.4 5660.5 1102.6 1216.2 1323.6 1333.6 1353.1 752.0 774.3 836.6 856.4 905.3 4986.3 5269.8 5302.9 5306.8 5339.5 5245.4 5775.6 5796.6 5840.6 5861.8 4761.4 5057.4 5130.7 5270.7 5310.6 2599.8 2605.1 2630.7 3060.8 3082.9 5251.4 5676.5 5713.7 5940.8 5994.3 4936.9 5925.6 5951.8 5966.9 5969.9 5888.4 5910.8 5987.9 6020.5 6063.0 5120.5 5420.5 5618.9 5729.8 5776.8 5038.0 5602.7 5626.4 5641.0 5714.6 5187.8 5715.4 5964.9 6017.5 6031.0 3318.4 3599.5 3854.2 3871.0 3931.3 4485.4 5203.5 5435.6 5927.7 5973.9 5512.4 5767.3 5783.3 5786.4 5795.0 4484.2 4699.4 4976.6 5484.9 5618.9 4625.4 4654.8 5298.6 5499.6 5587.9 5187.6 5303.0 5341.0 5713.5 5719.7 5119.6 5586.6 5602.6 5609.8 5625.8 06:33:24 INFO - PROCESS | 3018 | 06:33:24 INFO - PROCESS | 3018 | [#5] yui.html Cycles:180 Average:24201.46 Median:12730.72 stddev:37885.62 (297.6%) stddev-sans-first:37950.75 06:33:24 INFO - PROCESS | 3018 | Values: 686.7 736.5 797.9 828.2 856.6 14394.3 15256.2 15333.6 15420.0 15443.4 14591.3 14759.2 14779.7 14780.9 14815.6 700.3 733.7 859.1 874.7 901.0 867.4 878.8 882.5 883.4 885.7 940.4 940.5 940.7 942.2 942.7 733.6 913.1 935.1 949.5 950.7 700.4 700.7 701.2 702.5 702.6 14690.0 14734.0 14744.4 14750.8 14753.5 13893.0 13953.3 13973.3 14021.4 14154.0 12711.9 12770.1 12837.8 13005.5 13063.4 4609.3 4612.2 4737.2 4794.9 4803.2 108956.0 110612.3 110786.5 111210.4 112507.4 11124.0 11228.2 11269.9 11270.4 11414.0 21707.2 21981.2 21984.6 22077.4 22088.8 7943.8 7978.0 8010.7 8018.6 8122.4 4434.5 4505.1 4515.3 4516.0 4656.0 3372.7 3487.7 3491.7 3492.6 3493.5 658.0 666.5 671.5 672.5 675.5 520.6 629.3 631.6 654.8 656.0 9151.6 9436.7 9512.5 9556.4 9706.0 590.4 623.9 643.8 682.7 701.8 4565.0 4653.3 4706.3 4749.5 4751.7 139778.5 141138.0 145028.0 145303.0 146194.5 114451.0 120036.0 120376.0 122005.8 122388.4 98734.0 100344.0 103834.9 109338.2 110971.4 9566.7 9797.5 9903.2 10172.5 10225.6 44537.2 49872.0 57694.0 59110.0 64224.0 87278.0 88716.0 88872.6 90462.5 91318.5 11292.8 11730.6 11879.6 12075.4 12604.2 12846.9 14558.1 15342.2 15558.8 16073.8 12219.4 13824.0 14074.4 14494.1 14603.5 13095.8 13997.9 14006.9 14589.2 14935.1 11476.0 13765.2 14012.6 14047.4 14151.4 11386.1 11470.3 11672.5 11747.0 12239.2 11234.5 11536.9 11651.7 11704.9 11711.2 06:33:24 INFO - PROCESS | 3018 | -------- Summary: end -------- 06:33:24 INFO - PROCESS | 3018 | 06:33:25 INFO - TEST-INFO | 3018: exit 0 06:33:25 INFO - TEST-OK | dromaeo_css | took 1116690ms 06:33:25 INFO - TEST-START | kraken 06:33:25 INFO - operating with platform_type : mac_ 06:33:25 INFO - Initialising browser for kraken test... 06:33:25 INFO - TEST-INFO | started process 3133 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpkzIj4i/profile http://localhost:54484/getInfo.html) 06:33:27 INFO - PROCESS | 3133 | __metrics Screen width/height:1600/1200 06:33:27 INFO - PROCESS | 3133 | colorDepth:24 06:33:27 INFO - PROCESS | 3133 | Browser inner width/height: 1024/689 06:33:27 INFO - PROCESS | 3133 | __metrics 06:33:27 INFO - PROCESS | 3133 | 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" 06:33:27 INFO - PROCESS | 3133 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:33:28 INFO - TEST-INFO | 3133: exit 0 06:33:28 INFO - Browser initialized. 06:33:28 INFO - Running cycle 1/1 for kraken test... 06:33:28 INFO - TEST-INFO | started process 3136 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpkzIj4i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:33:40 INFO - PROCESS | 3136 | RSS: Main: 244879360 06:33:40 INFO - PROCESS | 3136 | 06:33:42 INFO - PROCESS | 3136 | Cycle 1(1): loaded http://localhost:54484/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54484/tests/kraken/driver.html?testName=audio-beat-detection) 06:33:43 INFO - PROCESS | 3136 | RSS: Main: 294334464 06:33:43 INFO - PROCESS | 3136 | 06:33:46 INFO - PROCESS | 3136 | Cycle 1(1): loaded http://localhost:54484/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54484/tests/kraken/driver.html?testName=audio-dft) 06:33:46 INFO - PROCESS | 3136 | RSS: Main: 305528832 06:33:46 INFO - PROCESS | 3136 | 06:33:50 INFO - PROCESS | 3136 | Cycle 1(1): loaded http://localhost:54484/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54484/tests/kraken/driver.html?testName=audio-fft) 06:33:51 INFO - PROCESS | 3136 | RSS: Main: 388255744 06:33:51 INFO - PROCESS | 3136 | 06:33:53 INFO - PROCESS | 3136 | Cycle 1(1): loaded http://localhost:54484/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54484/tests/kraken/driver.html?testName=audio-oscillator) 06:33:53 INFO - PROCESS | 3136 | RSS: Main: 290320384 06:33:53 INFO - PROCESS | 3136 | 06:33:55 INFO - PROCESS | 3136 | Cycle 1(1): loaded http://localhost:54484/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54484/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:33:56 INFO - PROCESS | 3136 | RSS: Main: 294486016 06:33:56 INFO - PROCESS | 3136 | 06:33:59 INFO - PROCESS | 3136 | Cycle 1(1): loaded http://localhost:54484/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54484/tests/kraken/driver.html?testName=imaging-darkroom) 06:33:59 INFO - PROCESS | 3136 | RSS: Main: 330178560 06:33:59 INFO - PROCESS | 3136 | 06:34:02 INFO - PROCESS | 3136 | Cycle 1(1): loaded http://localhost:54484/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54484/tests/kraken/driver.html?testName=imaging-desaturate) 06:34:03 INFO - PROCESS | 3136 | RSS: Main: 333590528 06:34:03 INFO - PROCESS | 3136 | 06:34:05 INFO - PROCESS | 3136 | Cycle 1(1): loaded http://localhost:54484/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54484/tests/kraken/driver.html?testName=json-parse-financial) 06:34:06 INFO - PROCESS | 3136 | RSS: Main: 332189696 06:34:06 INFO - PROCESS | 3136 | 06:34:08 INFO - PROCESS | 3136 | Cycle 1(1): loaded http://localhost:54484/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54484/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:34:08 INFO - PROCESS | 3136 | RSS: Main: 311861248 06:34:08 INFO - PROCESS | 3136 | 06:34:10 INFO - PROCESS | 3136 | Cycle 1(1): loaded http://localhost:54484/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54484/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:34:11 INFO - PROCESS | 3136 | RSS: Main: 318406656 06:34:11 INFO - PROCESS | 3136 | 06:34:13 INFO - PROCESS | 3136 | Cycle 1(1): loaded http://localhost:54484/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54484/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:34:14 INFO - PROCESS | 3136 | RSS: Main: 316002304 06:34:14 INFO - PROCESS | 3136 | 06:34:17 INFO - PROCESS | 3136 | Cycle 1(1): loaded http://localhost:54484/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54484/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:34:17 INFO - PROCESS | 3136 | RSS: Main: 325197824 06:34:17 INFO - PROCESS | 3136 | 06:34:20 INFO - PROCESS | 3136 | Cycle 1(1): loaded http://localhost:54484/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54484/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:34:21 INFO - PROCESS | 3136 | RSS: Main: 326647808 06:34:21 INFO - PROCESS | 3136 | 06:34:22 INFO - PROCESS | 3136 | Cycle 1(1): loaded http://localhost:54484/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54484/tests/kraken/driver.html?testName=ai-astar) 06:34:23 INFO - PROCESS | 3136 | RSS: Main: 370421760 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | __start_tp_report 06:34:23 INFO - PROCESS | 3136 | _x_x_mozilla_page_load 06:34:23 INFO - PROCESS | 3136 | _x_x_mozilla_page_load_details 06:34:23 INFO - PROCESS | 3136 | |i|pagename|runs| 06:34:23 INFO - PROCESS | 3136 | |0;ai-astar;102;112;113;113;113;112;113;112;112;112 06:34:23 INFO - PROCESS | 3136 | |1;audio-beat-detection;143;114;103;157;107;106;128;105;142;106 06:34:23 INFO - PROCESS | 3136 | |2;audio-dft;185;184;185;186;183;185;181;177;184;184 06:34:23 INFO - PROCESS | 3136 | |3;audio-fft;80;76;57;105;56;57;62;65;97;57 06:34:23 INFO - PROCESS | 3136 | |4;audio-oscillator;84;87;92;71;69;69;97;70;68;102 06:34:23 INFO - PROCESS | 3136 | |5;imaging-gaussian-blur;88;84;87;86;87;85;87;84;86;84 06:34:23 INFO - PROCESS | 3136 | |6;imaging-darkroom;93;92;109;150;105;93;93;92;92;93 06:34:23 INFO - PROCESS | 3136 | |7;imaging-desaturate;84;85;86;86;86;85;87;86;87;86 06:34:23 INFO - PROCESS | 3136 | |8;json-parse-financial;56;53;52;56;53;53;54;56;54;54 06:34:23 INFO - PROCESS | 3136 | |9;json-stringify-tinderbox;62;76;106;108;87;70;69;69;71;71 06:34:23 INFO - PROCESS | 3136 | |10;stanford-crypto-aes;80;96;99;101;99;77;84;78;82;84 06:34:23 INFO - PROCESS | 3136 | |11;stanford-crypto-ccm;137;137;141;146;150;141;135;136;180;137 06:34:23 INFO - PROCESS | 3136 | |12;stanford-crypto-pbkdf2;162;163;161;160;161;163;159;160;161;159 06:34:23 INFO - PROCESS | 3136 | |13;stanford-crypto-sha256-iterative;67;65;66;66;66;67;66;66;66;65 06:34:23 INFO - PROCESS | 3136 | __end_tp_report 06:34:23 INFO - PROCESS | 3136 | __start_cc_report 06:34:23 INFO - PROCESS | 3136 | _x_x_mozilla_cycle_collect,1973 06:34:23 INFO - PROCESS | 3136 | __end_cc_report 06:34:23 INFO - PROCESS | 3136 | __startTimestamp1467552863117__endTimestamp 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | ------- Summary: start ------- 06:34:23 INFO - PROCESS | 3136 | Number of tests: 14 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:3.34 (3.0%) stddev-sans-first:0.53 06:34:23 INFO - PROCESS | 3136 | Values: 102.0 112.0 113.0 113.0 113.0 112.0 113.0 112.0 112.0 112.0 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | [#1] audio-beat-detection Cycles:10 Average:121.10 Median:121.00 stddev:19.85 (16.4%) stddev-sans-first:19.40 06:34:23 INFO - PROCESS | 3136 | Values: 143.0 114.0 103.0 157.0 107.0 106.0 128.0 105.0 142.0 106.0 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.50 stddev:2.63 (1.4%) stddev-sans-first:2.73 06:34:23 INFO - PROCESS | 3136 | Values: 185.0 184.0 185.0 186.0 183.0 185.0 181.0 177.0 184.0 184.0 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | [#3] audio-fft Cycles:10 Average:71.20 Median:63.50 stddev:17.85 (28.1%) stddev-sans-first:18.65 06:34:23 INFO - PROCESS | 3136 | Values: 80.0 76.0 57.0 105.0 56.0 57.0 62.0 65.0 97.0 57.0 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | [#4] audio-oscillator Cycles:10 Average:80.90 Median:77.50 stddev:13.08 (16.9%) stddev-sans-first:13.83 06:34:23 INFO - PROCESS | 3136 | Values: 84.0 87.0 92.0 71.0 69.0 69.0 97.0 70.0 68.0 102.0 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:86.50 stddev:1.48 (1.7%) stddev-sans-first:1.33 06:34:23 INFO - PROCESS | 3136 | Values: 88.0 84.0 87.0 86.0 87.0 85.0 87.0 84.0 86.0 84.0 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | [#6] imaging-darkroom Cycles:10 Average:101.20 Median:92.50 stddev:18.20 (19.7%) stddev-sans-first:19.06 06:34:23 INFO - PROCESS | 3136 | Values: 93.0 92.0 109.0 150.0 105.0 93.0 93.0 92.0 92.0 93.0 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:0.92 (1.1%) stddev-sans-first:0.71 06:34:23 INFO - PROCESS | 3136 | Values: 84.0 85.0 86.0 86.0 86.0 85.0 87.0 86.0 87.0 86.0 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.45 (2.7%) stddev-sans-first:1.36 06:34:23 INFO - PROCESS | 3136 | Values: 56.0 53.0 52.0 56.0 53.0 53.0 54.0 56.0 54.0 54.0 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | [#9] json-stringify-tinderbox Cycles:10 Average:78.90 Median:70.50 stddev:16.13 (22.9%) stddev-sans-first:15.90 06:34:23 INFO - PROCESS | 3136 | Values: 62.0 76.0 106.0 108.0 87.0 70.0 69.0 69.0 71.0 71.0 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:84.00 stddev:9.59 (11.4%) stddev-sans-first:9.73 06:34:23 INFO - PROCESS | 3136 | Values: 80.0 96.0 99.0 101.0 99.0 77.0 84.0 78.0 82.0 84.0 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:141.00 stddev:13.52 (9.6%) stddev-sans-first:14.10 06:34:23 INFO - PROCESS | 3136 | Values: 137.0 137.0 141.0 146.0 150.0 141.0 135.0 136.0 180.0 137.0 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.00 stddev:1.45 (0.9%) stddev-sans-first:1.48 06:34:23 INFO - PROCESS | 3136 | Values: 162.0 163.0 161.0 160.0 161.0 163.0 159.0 160.0 161.0 159.0 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - PROCESS | 3136 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 06:34:23 INFO - PROCESS | 3136 | Values: 67.0 65.0 66.0 66.0 66.0 67.0 66.0 66.0 66.0 65.0 06:34:23 INFO - PROCESS | 3136 | -------- Summary: end -------- 06:34:23 INFO - PROCESS | 3136 | 06:34:23 INFO - TEST-INFO | 3136: exit 0 06:34:23 INFO - TEST-OK | kraken | took 58520ms 06:34:23 INFO - SUITE-END | took 1175s 06:34:24 INFO - Completed test suite (00:19:35) 06:34:24 INFO - javascript benchmark 06:34:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3367.343368043231, 3389.745794056198, 3423.503591979162, 3425.811580363079, 3467.0812234757777, 5721.799737009205, 5798.507126894208, 5835.824925252244, 5873.618214816034, 5881.764729410824, 5825.388334224909, 5841.941580584193, 5925.407459254073, 5953.821385358436, 5965.88068238635, 5168.948310516885, 5169.405518365398, 5223.973880130594, 5255.894882102375, 5354.303940487731, 5333.893322133555, 5359.705216213107, 5367.194920761878, 5379.193121031857, 5420.159875219348, 5168.250603662466, 5206.713630750307, 5224.73876306187, 5279.366476022902, 5311.654742441729, 4642.839290177456, 5048.293238946514, 5261.026710058652, 5269.314989051399, 5269.894602107936, 5187.118189907687, 5221.530062294374, 5235.319408476912, 5251.212318152269, 5262.394824595144, 5754.280714910637, 5778.479936805707, 5781.219535362714, 5809.070548712186, 5820.476157145835, 6283.497320214417, 6330.050492426127, 6343.777967771152, 6351.364863513611, 6355.0, 6124.808163753419, 6266.060090986343, 6294.842628934268, 6299.0, 6316.336784637639, 5899.581381192614, 5987.371326010793, 5990.7903223386975, 6001.489873360726, 6001.7599296027665, 5405.21624364465, 6312.368763123651, 6318.115463835067, 6320.747170113236, 6330.335314791972, 6107.0, 6177.907331390033, 6238.064290356483, 6244.2819075805955, 6285.088662143963, 6284.371562843679, 6308.148399965946, 6315.431611155018, 6316.526260530479, 6328.11406403104, 6147.262328520516, 6336.746530138835, 6343.746250149942, 6345.365463453618, 6347.270063942706, 6245.781397651061, 6296.527760417987, 6326.873462530723, 6329.145565348711, 6367.108604795332, 5006.048850718352, 5006.786156241227, 5009.273655319958, 5010.549050585465, 5021.196608542616, 4457.175422546839, 4458.331250312414, 4491.124230774967, 4502.054568540643, 4537.319402089713, 5719.571032172604, 5782.421757824268, 5813.709314534256, 5813.79651712188, 5826.271716035496, 6255.437010669061, 6331.05034244867, 6340.778072767431, 6341.270753863365, 6350.142730731292, 5837.9124313135335, 5871.089981052944, 5889.263842019747, 5900.76396944126, 5951.702414879239, 5526.806561770319, 5547.944520554743, 5553.222548843084, 5553.666779993213, 5562.860928476821, 6205.937940620716, 6250.656213908279, 6360.491160707133, 6365.586236894587, 6369.968150159127, 6253.499720022478, 6285.2457705075685, 6299.748010079546, 6302.527310451826, 6303.212098487689, 6260.655663938345, 6311.274203466476, 6318.589291696025, 6330.556861019869, 6345.079963405373, 6133.059244992972, 6185.257769067741, 6216.2540495140875, 6324.051392291193, 6326.9683651581445, 6281.277653069956, 6284.434400903758, 6301.905471418024, 6312.842178945563, 6337.683115844097, 6229.0967809668255, 6229.937700622936, 6231.439170474498, 6233.625982440886, 6249.968750156402, 6040.365761595145, 6096.345267793883, 6107.583301036431, 6163.137160797402, 6193.6903154841175, 6074.3318234994995, 6077.20996270482, 6093.238345206849, 6098.115773212948, 6100.969495152496, 5115.386153661584, 6216.316205217513, 6229.345918678474, 6240.656763878031, 6240.719167637377, 5885.323187833283, 5994.970025149846, 6048.667323297261, 6100.633961962297, 6120.571559990936], "value": 5774.824797861449, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.1910152175322, 476.61156157731466, 496.4167103653207, 524.493863421798, 542.6906663201975, 30343.696563034362, 32398.838005809997, 32809.68761249553, 41066.79466602667, 41688.58311416885, 42332.0, 43568.34647480283, 43695.56304436955, 43719.0, 43769.562304376945, 9622.903770962288, 9777.364471309342, 9810.852837207447, 9811.264155188353, 9811.901880981206, 8672.0, 8873.20141187293, 8875.911240887574, 8918.197362237397, 8935.06181850906, 11655.533778648887, 11924.582639607615, 11932.031214849583, 12129.696757581087, 12149.149559530837, 11902.523899044028, 11928.284302941851, 11998.280103193836, 12003.399830008508, 12015.038796896315, 8605.698800542013, 8813.647454101829, 8818.382713210078, 11694.532218711242, 11780.764384712344, 32439.675603244137, 39849.0, 40149.99625009369, 40204.59795402038, 42819.0, 3468.3756923753713, 3509.175343794232, 3564.946525802115, 3696.5379327583782, 3817.1983883384523, 28981.13056608305, 29101.272468188254, 32154.356912861847, 32836.507452387996, 32888.848890288726, 3279.212988882675, 3290.8190049547507, 3321.534985102088, 3376.5610470638903, 3443.6384179661027, 507130.0, 507914.0, 508720.0, 510248.0, 510703.0, 51003.0, 57487.13769293464, 57828.4217157823, 57924.71037644869, 61982.0, 63721.36278637247, 63927.360726392144, 63975.0, 64093.679531602975, 64307.35692643013, 16042.117683527518, 16155.434559790587, 16233.83766162347, 16236.350545978028, 16243.106629135511, 12520.31138287403, 12566.685832854251, 12585.433655485525, 12698.555550555686, 12703.809442858179, 12231.510739570318, 14584.1978691173, 16323.0, 16424.1787910604, 16665.583360416087, 6345.428911397904, 6351.682415879188, 6362.491000719931, 6387.137736405619, 6395.584287021329, 910.717677519971, 1025.4206373399006, 1025.8922813104666, 1040.7138037039874, 1126.6732647532124, 30364.69635303663, 30521.0, 30546.84726576353, 31153.8442307787, 31209.0, 864.5288317866778, 925.0, 966.6230170233614, 1117.9161562882816, 1120.8935151160626, 15801.446949356718, 15969.520914372355, 16034.919825400799, 16375.918120409322, 16391.83608163927, 630824.0, 643148.0, 647916.0, 650444.0, 651789.0, 58481.41518584845, 59138.40861591329, 59159.0, 59193.0, 59453.999999999134, 1270.7712611729792, 1301.1802564384377, 1398.454602704946, 1412.971740565183, 1429.6140042188551, 30934.381312374077, 31219.687803122586, 31752.682473174973, 32371.838140809145, 32481.35037299288, 55756.163657544355, 56620.0, 56646.43353566412, 56740.43259567516, 56753.71623141858, 586260.0, 605543.0, 605900.0, 607163.0, 607397.0, 34549.48175777315, 40362.596374035886, 40792.184156316114, 41026.0, 41877.79061104675, 47973.0, 48073.0, 48710.5128948706, 49547.25679114744, 49828.50171498238, 39382.409263861635, 39407.80296098501, 39716.80141599273, 40396.99007524835, 40546.0, 37202.8139859299, 38620.80689596534, 39551.60448395594, 40284.0, 40330.160380754496, 37726.43410348902, 38201.0, 38577.0, 38592.8422147336, 38722.0, 30969.0, 34163.65836341605, 34450.0, 35324.11689707778, 36985.630143699294, 25521.74478255268, 25849.353766155244, 25857.612135817602, 25931.092411765498, 26174.60738088892], "value": 20449.21225427255, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.542395222736, 362.15798269024515, 386.19093000164645, 388.18674876134486, 407.20594840061887, 14339.067960582568, 16519.587010324733, 20248.29130980416, 20549.589008219828, 20608.38174854753, 19580.706289405636, 20294.0, 20605.896970515125, 20615.793842061576, 20926.37220883372, 5590.0, 5851.912221316684, 6100.23747031621, 6119.204503414572, 6121.938780612181, 6012.75948962041, 6103.603265787732, 6104.023356262999, 6113.938860611382, 6140.048292514645, 5764.855878603047, 5983.640981541122, 6002.969985150068, 6067.969660151715, 6069.544784141185, 5986.191864098335, 6002.939970600303, 6015.669138197398, 6034.818955431322, 6046.365131661156, 5016.874578135539, 5258.8685282867855, 5264.236685680555, 5270.183121616117, 5280.788768449257, 25551.872240638677, 26077.60883586748, 26094.34764130893, 26453.470930581472, 26528.867355663293, 1905.637928793525, 2184.1809321504434, 2332.4052366646397, 2772.3900741836765, 3125.8124512529093, 14920.477783277642, 15916.124613146272, 16092.275847586887, 16193.838061619468, 16392.67214655712, 1707.7011522983428, 1775.2366482412558, 1865.2259312385345, 1924.9422517324504, 2123.9150433982622, 101635.9836401634, 102197.97802022034, 107961.0, 108866.45566772195, 112427.31359029702, 10651.254412191227, 11074.612388566362, 11695.766084678258, 11726.648200553997, 11897.226680265756, 14562.0, 14612.634684132981, 14619.634509137144, 14655.193964331851, 14663.533646635251, 8253.95873020643, 8393.874091888627, 8439.873401898976, 8492.023417306966, 8519.275861551714, 6816.386525212754, 8344.958275208584, 8372.832543349221, 8466.153384661608, 8466.238038576434, 4484.215262329079, 4567.885802854888, 4578.45058592971, 4610.593768900518, 4619.6073333766335, 1597.560670815535, 1670.189957870432, 1868.9719654205198, 1913.1390874106708, 1946.153423260886, 898.7169041751828, 905.4295793649958, 951.4814426137772, 954.0364232125603, 962.5572236771163, 20389.694154587694, 21479.140834366764, 21563.344987767698, 21586.78413215848, 21660.45848853791, 905.9229965452879, 929.1683942871227, 947.6825263536655, 949.4066208619613, 983.1643103362085, 9950.169184863735, 11133.498992545194, 11220.719482012852, 11280.548778048951, 11311.717207069725, 622596.0, 627383.0, 640647.0, 645606.0, 655523.0, 143684.0, 145319.54680453273, 148918.0, 150552.2472387653, 153085.4691453071, 990.6433683873944, 1004.7337455574278, 1006.2955930848435, 1031.9380837149795, 1033.2973577966904, 19216.0, 19349.4195174145, 20456.0, 20524.618962540146, 20892.268770592957, 57604.847903042544, 58728.0, 58817.0, 59208.70395647994, 59538.70230648819, 77326.0, 78896.60551697205, 80446.5977670108, 87457.56271218603, 88669.55665221633, 7071.292870712888, 7339.64216619927, 7345.118585769742, 7617.733379331697, 8116.431849770459, 9123.954380228322, 12436.0, 12840.935795320964, 13198.538051168163, 13222.008349373644, 11216.929106375457, 11268.323900565993, 11277.32336059839, 11370.94314528422, 11407.315561066363, 11071.667849964513, 11154.0, 11293.686626080955, 11326.263792853439, 11359.659210223375, 5729.054705973468, 10953.56185752561, 11539.307641541534, 11606.651800446, 11769.529218831492, 7001.824954376181, 7153.892691609734, 7339.669714862737, 7378.815529611803, 7443.851122977619, 8069.0, 9892.258080644124, 11025.503852326825, 11265.887341126483, 11364.090872730327], "value": 9689.088080056426, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.2270728392095, 1476.23235917323, 1518.69626074785, 1719.166204390871, 1902.933397331093, 7646.92353076469, 8489.108643592426, 8648.697295594655, 8673.69642062528, 8797.07630698777, 8486.872696909551, 8546.572671366437, 8625.309975201984, 8627.13728627137, 8668.696595619138, 2054.4863784053987, 2353.9058437662475, 2368.0, 2379.3694670912223, 2384.582698027847, 2336.217367181996, 2367.3134790910617, 2377.2868139558063, 2385.022140922222, 2391.9760802392016, 2337.6610391493223, 2364.18435639704, 2375.92872213833, 2379.333786539763, 2380.2621187431864, 2317.084751523139, 2338.871362075085, 2353.999550191179, 2354.3054798834387, 2367.147826782374, 2340.5435939991708, 2344.2146880794953, 2345.2143531916827, 2345.7302410222874, 2351.2711059571416, 8459.45013574122, 8627.30981521483, 8631.568421578895, 8699.739007829776, 8701.30389568833, 5139.049275883974, 5324.094903866313, 5331.973340133274, 5333.413324534298, 5334.946650533522, 3619.167591453954, 3636.727245456575, 3670.926581468356, 3711.350513660099, 3714.739968202227, 1096.309325125174, 1098.1599076706325, 1102.1898904305328, 1119.5074167366333, 1132.0603898764089, 9822.508874556244, 11317.717057073556, 11426.88573114275, 11463.36951467669, 11472.827907581393, 3678.9448158277646, 4380.189664912002, 4585.564371384713, 4608.723476591348, 4614.192516309632, 8960.955195223982, 8980.595873185723, 8980.640774368952, 8986.0, 8986.460812351279, 5193.974030129825, 5198.480151984847, 5203.063448579216, 5204.4014938281825, 5206.062908676399, 3764.548254209458, 4384.912301753947, 4517.841875534341, 4832.4684284728655, 4871.878203044881, 3753.436984452354, 3782.5460944686815, 3808.0, 3846.769193848378, 3854.845806167778, 1146.0602306109076, 1160.3675996581883, 1161.1523587780966, 1169.6724917023248, 1172.1619042384737, 907.9409838360485, 911.4855126484741, 915.4919019943862, 933.7338858425317, 973.109604711695, 5815.563832712563, 5825.359210486843, 5916.704164791743, 6035.818925432244, 6081.665508396992, 438.931965545341, 445.3631307230626, 451.94124763780496, 460.4060761617476, 468.16432667688014, 3795.658390744846, 3920.09837737322, 4013.5585085640555, 4094.877153685394, 4126.051008268115, 10189.439580823126, 10583.947080264703, 10712.678619641423, 10717.0, 10753.51609177589, 10663.093637040784, 10669.0, 10673.626423075155, 10676.0, 10728.517216725266, 7683.462157648911, 8111.634976426075, 8130.308923741548, 8244.175582441827, 8253.504789712637, 5760.33756118035, 6031.879362412815, 6036.185115009594, 6087.904177248138, 6099.298580663103, 9403.294752893424, 9526.761830954281, 10064.39613623185, 10065.345752526062, 10076.596936122472, 10043.69868903934, 10248.026437488426, 10248.692539223835, 10263.0, 10330.018648228406, 7431.071116110486, 7514.0, 7553.886691699519, 7572.091349037931, 7592.8861067085145, 8015.519068855654, 8081.797955050935, 8082.878756818534, 8090.878636820335, 8103.918960810316, 6416.550841441054, 7318.560886346836, 7432.851342973002, 7435.4795164337975, 7527.698892044257, 6260.968695156495, 7290.234525374972, 7296.0, 7342.265773422615, 7443.106827180773, 6625.370589793962, 6905.585664860125, 6976.267491913479, 6985.755498557526, 6992.265812089658, 4269.889828644513, 4676.158291507561, 5016.724080175625, 5077.714036167257, 5152.175651895679, 5082.949170508247, 5126.897462050663, 5156.458571849902, 5164.9741751291, 5183.688978661293], "value": 4441.685445441071, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [247.9429731161833, 295.3266552260846, 311.5715890650356, 311.78019496255143, 312.788867514428, 4486.3494793254995, 4977.178765503692, 5219.8434046978555, 5399.7860877040375, 5497.312835895513, 5098.09408637077, 5106.131957567213, 5277.947220527793, 5288.312519372476, 5391.649542779726, 3023.8790448382147, 3817.9045523861846, 4062.1875624874997, 4072.3484242521204, 4088.5707000764787, 3605.2068544920076, 4062.878113656595, 4072.4705788247634, 4073.6780035379848, 4110.732802367851, 3755.6619904208615, 3883.5533913599875, 3898.5906479819637, 4020.376841589544, 4052.1085361220485, 3350.8659653613827, 4044.47421835161, 4045.4134150548007, 4049.4128351388886, 4065.5527891931865, 3461.3769521486124, 3530.73519486037, 3531.474995378291, 3547.6452354764574, 3549.0594992327055, 4489.6408287336935, 4844.59217991961, 5240.292560504321, 5261.710605916673, 5273.8620520790455, 4379.956200437987, 4642.4679855647555, 4678.777580649198, 4679.789409476548, 4686.81252749893, 5411.702356370398, 5572.916406253909, 5631.549476041907, 5663.207150998864, 5703.258576385043, 3301.3397320535987, 3424.417848965682, 3894.571597124314, 3924.7056470764524, 3927.7839718815453, 5517.200005999108, 5827.854303642401, 5868.4424979626865, 5878.177055212273, 5935.26977590309, 3464.913377165591, 3786.413105968579, 3866.3233934061427, 3868.7485313454536, 3882.76703397797, 3415.79505229687, 3930.253251882133, 3954.940675889864, 3970.4639873616693, 3974.158476689181, 4402.9559704402545, 4561.589456948891, 4606.861794146181, 4640.3967484227505, 4645.0, 4518.502964673883, 5523.972380138073, 5595.832125036255, 5635.380108188096, 5660.518855897212, 1102.5589764094266, 1216.2216181643755, 1323.5632241360329, 1333.599920023989, 1353.1137105196112, 751.9510283154968, 774.3224678406394, 836.5691668790578, 856.3662889461754, 905.2803021597846, 4986.282476050488, 5269.815556455583, 5302.946970530323, 5306.787728490895, 5339.492748188916, 5245.396779370345, 5775.624584402, 5796.594238403271, 5840.649561026352, 5861.794837180678, 4761.381020467317, 5057.367829021372, 5130.717810520383, 5270.736463176826, 5310.575153987672, 2599.7790187833866, 2605.0751983046125, 2630.7237740037403, 3060.8469576521084, 3082.9383412331626, 5251.369835619674, 5676.460736230051, 5713.74307148674, 5940.79207227745, 5994.310654274815, 4936.925946110811, 5925.585209035412, 5951.827582932285, 5966.940330596725, 5969.880602387928, 5888.352281249059, 5910.793122240787, 5987.904233518234, 6020.54845886569, 6062.999999999912, 5120.513551212629, 5420.512153906167, 5618.85952851182, 5729.828105156852, 5776.768929242783, 5037.967216720637, 5602.711376383373, 5626.35296940857, 5641.0, 5714.5999780015, 5187.792488300426, 5715.428457154251, 5964.850878728066, 6017.525706202008, 6031.035034394476, 3318.4192766265323, 3599.478075679064, 3854.20988697322, 3871.0, 3931.2923673739, 4485.420882992357, 5203.453637368173, 5435.565154787529, 5927.673977931255, 5973.880522389615, 5512.448755124616, 5767.250257466502, 5783.334916484658, 5786.4213578643485, 5794.971025144847, 4484.215262329014, 4699.365585645894, 4976.626752993612, 5484.862878428071, 5618.85952851182, 4625.352450656844, 4654.790534426027, 5298.5958720938215, 5499.642523235977, 5587.8882422352135, 5187.559057480005, 5302.973485132549, 5341.011912796145, 5713.543046523277, 5719.685417302088, 5119.616028797781, 5586.608937374344, 5602.607817452739, 5609.831705048855, 5625.774969001194], "value": 4072.367969702252, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.7356067913853, 736.4881407421844, 797.9082405523367, 828.1594181905365, 856.6402111113332, 14394.280285985698, 15256.160911149882, 15333.616659583502, 15419.997700149483, 15443.382264709413, 14591.27043647816, 14759.18824464654, 14779.704405911902, 14780.926095369508, 14815.629609259773, 700.3276854219955, 733.7431898835391, 859.1451505751786, 874.7200895713374, 900.9954950225273, 867.3754896474528, 878.8242351529688, 882.496976723268, 883.3683916000059, 885.7032893980524, 940.4263399326439, 940.4921342475055, 940.6566603189821, 942.2226663003015, 942.6512190489494, 733.5525329548971, 913.0869130869131, 935.1350001248818, 949.4872768704892, 950.6910254167424, 700.4396482813779, 700.726716580534, 701.1621112770241, 702.5012241308677, 702.5679207287482, 14690.0, 14734.042287251294, 14744.410223591043, 14750.778738318933, 14753.483628072965, 13893.027488075839, 13953.302334883216, 13973.301334933212, 14021.369038393297, 14154.0, 12711.872881271162, 12770.106092573524, 12837.814215292154, 13005.544805931842, 13063.412146453433, 4609.285560738091, 4612.215923293048, 4737.2420412734145, 4794.856154315341, 4803.159447096744, 108956.0, 110612.34081488784, 110786.46067696583, 111210.44394778056, 112507.43746281216, 11124.0, 11228.214025018171, 11269.887301126884, 11270.380129092815, 11413.97274245322, 21707.240246591293, 21981.23065692693, 21984.560308793734, 22077.448063798533, 22088.779112208995, 7943.841123177504, 7978.0, 8010.719624813103, 8018.5990700464745, 8122.3502119831455, 4434.490033646172, 4505.098980203972, 4515.345274935116, 4515.977420112944, 4656.045510670305, 3372.650939624121, 3487.6512348764923, 3491.685748282616, 3492.5808902931303, 3493.475978603179, 658.0, 666.4601672645076, 671.5366397185926, 672.5124284893413, 675.4933799650262, 520.6017396691534, 629.2511910826103, 631.5736877607596, 654.8264709851893, 656.0, 9151.588178531982, 9436.716898493056, 9512.479193013856, 9556.426614403159, 9706.0, 590.3801008940595, 623.8752249550108, 643.8326035230874, 682.7030241844814, 701.8491024429773, 4565.0, 4653.325267836145, 4706.294055891643, 4749.548792864673, 4751.691140075953, 139778.5055373624, 141138.0, 145028.0, 145303.0, 146194.5380546202, 114451.0, 120036.0, 120376.0, 122005.77994220122, 122388.38805805914, 98734.0, 100344.0, 103834.92330153355, 109338.23894993351, 110971.44514277538, 9566.66516671913, 9797.461139637388, 9903.207743380657, 10172.491375431051, 10225.590976360862, 44537.21433678173, 49872.0, 57694.0, 59110.0, 64224.0, 87278.0, 88716.0, 88872.5556372214, 90462.54768726115, 91318.54340728254, 11292.830607540729, 11730.589429369931, 11879.643610691694, 12075.39623018828, 12604.243745375306, 12846.893392105329, 14558.12651240929, 15342.23288835576, 15558.844411556192, 16073.839261607234, 12219.389030548615, 13824.0, 14074.437022518985, 14494.05788623736, 14603.488877889224, 13095.8213760762, 13997.930010349883, 14006.859931400555, 14589.197594132425, 14935.103893766409, 11476.0, 13765.242911639956, 14012.598740125906, 14047.438102475786, 14151.363188656329, 11386.146039047271, 11470.254433461798, 11672.533098675958, 11747.0, 12239.20445171061, 11234.494447749707, 11536.884631153582, 11651.650450486499, 11704.882951170379, 11711.238769479956], "value": 7907.816345794702, "unit": "score"}], "name": "dromaeo_css", "value": 7396.0469615314305, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 113.0, 113.0, 113.0, 112.0, 113.0, 112.0, 112.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 114.0, 103.0, 157.0, 107.0, 106.0, 128.0, 105.0, 142.0, 106.0], "value": 121.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 186.0, 183.0, 185.0, 181.0, 177.0, 184.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 57.0, 105.0, 56.0, 57.0, 62.0, 65.0, 97.0, 57.0], "value": 71.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 92.0, 71.0, 69.0, 69.0, 97.0, 70.0, 68.0, 102.0], "value": 80.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 86.0, 87.0, 85.0, 87.0, 84.0, 86.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 109.0, 150.0, 105.0, 93.0, 93.0, 92.0, 92.0, 93.0], "value": 101.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 86.0, 86.0, 85.0, 87.0, 86.0, 87.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 52.0, 56.0, 53.0, 53.0, 54.0, 56.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 76.0, 106.0, 108.0, 87.0, 70.0, 69.0, 69.0, 71.0, 71.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 96.0, 99.0, 101.0, 99.0, 77.0, 84.0, 78.0, 82.0, 84.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 141.0, 146.0, 150.0, 141.0, 135.0, 136.0, 180.0, 137.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 160.0, 161.0, 163.0, 159.0, 160.0, 161.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1432.7, "alertThreshold": 2.0}]} 06:34:24 INFO - Return code: 0 06:34:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:34:24 INFO - # TBPL SUCCESS # 06:34:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:34:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:34:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:34:24 INFO - 2016-07-03 06:34:24.424 screenresolution[3145:27706] starting screenresolution argv=screenresolution get 06:34:24 INFO - 2016-07-03 06:34:24.426 screenresolution[3145:27706] Display 0: 1600x1200x32@60 06:34:24 INFO - 2016-07-03 06:34:24.432 screenresolution[3146:27709] starting screenresolution argv=screenresolution list 06:34:24 INFO - Available Modes on Display 0 06:34:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:34:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:34:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:34:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:34:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:34:24 INFO - Intel Iris: 06:34:24 INFO - Chipset Model: Intel Iris 06:34:24 INFO - Type: GPU 06:34:24 INFO - Bus: Built-In 06:34:24 INFO - VRAM (Dynamic, Max): 1536 MB 06:34:24 INFO - Vendor: Intel (0x8086) 06:34:24 INFO - Device ID: 0x0a2e 06:34:24 INFO - Revision ID: 0x0009 06:34:24 INFO - Displays: 06:34:24 INFO - Display: 06:34:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:34:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:34:24 INFO - Display Serial Number: 1600x1200 60 06:34:24 INFO - Main Display: Yes 06:34:24 INFO - Mirror: Off 06:34:24 INFO - Online: Yes 06:34:24 INFO - Rotation: Supported 06:34:24 INFO - Return code: 0 06:34:24 INFO - Running post-action listener: _resource_record_post_action 06:34:24 INFO - ##### 06:34:24 INFO - ##### Finished run-tests step (success) 06:34:24 INFO - ##### 06:34:24 INFO - Running post-run listener: _resource_record_post_run 06:34:24 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 798720; Write bytes: 709685760; Read time: 6; Write time: 1996 06:34:24 INFO - TinderboxPrint: CPU usage
53.6% 06:34:24 INFO - TinderboxPrint: I/O read bytes / time
798,720 / 6 06:34:24 INFO - TinderboxPrint: I/O write bytes / time
709,685,760 / 1,996 06:34:24 INFO - TinderboxPrint: CPU idle
2,247.5 (46.4%) 06:34:24 INFO - TinderboxPrint: CPU system
971.6 (20.1%) 06:34:24 INFO - TinderboxPrint: CPU user
1,626.4 (33.6%) 06:34:24 INFO - TinderboxPrint: Swap in / out
407,216,128 / 0 06:34:24 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 404595200; Write bytes: 398521856; Read time: 31208; Write time: 862 06:34:24 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 753664; Write bytes: 299355136; Read time: 6; Write time: 1092 06:34:25 INFO - Running post-run listener: _upload_blobber_files 06:34:25 INFO - Blob upload gear active. 06:34:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:34:25 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 06:34:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:34:25 INFO - (blobuploader) - INFO - Open directory for files ... 06:34:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:34:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:34:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:26 INFO - (blobuploader) - INFO - Done attempting. 06:34:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:34:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:34:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:27 INFO - (blobuploader) - INFO - Done attempting. 06:34:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:34:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:34:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:30 INFO - (blobuploader) - INFO - Done attempting. 06:34:30 INFO - (blobuploader) - INFO - Iteration through files over. 06:34:30 INFO - Return code: 0 06:34:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:34:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:34:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3f5ef0eee4da209694efddece5f833e3af116fdc70468fbb9601af04fb2daf098b7b4c410400020d7dfcf61ca24f264d5f7b50b24ec39afbe6cc4bc77625b8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8ddf4efcea7be5e7bdac06277d88c3ef5e3886b12639c31b734e708a31dc3fe66cdd7c7c71282ccdc4f3e4bcc6ce2d01e58521096354bcd4f2a807ed1530671", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aef0a06a243bea378aa1d87201059aaca41c3779319b9384e746ae39f600d061c6f5dd07f5c952764bbd1689a079e0d8139deadcda5f31a27e20770a4089165c"} 06:34:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:34:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:34:30 INFO - Contents: 06:34:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3f5ef0eee4da209694efddece5f833e3af116fdc70468fbb9601af04fb2daf098b7b4c410400020d7dfcf61ca24f264d5f7b50b24ec39afbe6cc4bc77625b8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8ddf4efcea7be5e7bdac06277d88c3ef5e3886b12639c31b734e708a31dc3fe66cdd7c7c71282ccdc4f3e4bcc6ce2d01e58521096354bcd4f2a807ed1530671", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aef0a06a243bea378aa1d87201059aaca41c3779319b9384e746ae39f600d061c6f5dd07f5c952764bbd1689a079e0d8139deadcda5f31a27e20770a4089165c"} 06:34:30 INFO - Running post-run listener: copy_logs_to_upload_dir 06:34:30 INFO - Copying logs to upload dir... 06:34:30 INFO - mkdir: /builds/slave/test/build/upload/logs 06:34:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.522547 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-03 06:34:30.203393) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 06:34:30.207065) ========= 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.h1D7JpdjHW/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.bSb3jhBWtU/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3f5ef0eee4da209694efddece5f833e3af116fdc70468fbb9601af04fb2daf098b7b4c410400020d7dfcf61ca24f264d5f7b50b24ec39afbe6cc4bc77625b8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8ddf4efcea7be5e7bdac06277d88c3ef5e3886b12639c31b734e708a31dc3fe66cdd7c7c71282ccdc4f3e4bcc6ce2d01e58521096354bcd4f2a807ed1530671", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aef0a06a243bea378aa1d87201059aaca41c3779319b9384e746ae39f600d061c6f5dd07f5c952764bbd1689a079e0d8139deadcda5f31a27e20770a4089165c"} build_url:https://queue.taskcluster.net/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011087 build_url: 'https://queue.taskcluster.net/v1/task/MMVLQfeJTCGy8h3pNX_WJA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3f5ef0eee4da209694efddece5f833e3af116fdc70468fbb9601af04fb2daf098b7b4c410400020d7dfcf61ca24f264d5f7b50b24ec39afbe6cc4bc77625b8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8ddf4efcea7be5e7bdac06277d88c3ef5e3886b12639c31b734e708a31dc3fe66cdd7c7c71282ccdc4f3e4bcc6ce2d01e58521096354bcd4f2a807ed1530671", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aef0a06a243bea378aa1d87201059aaca41c3779319b9384e746ae39f600d061c6f5dd07f5c952764bbd1689a079e0d8139deadcda5f31a27e20770a4089165c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 06:34:30.238694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 06:34:30.239007) ========= 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.h1D7JpdjHW/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.bSb3jhBWtU/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.005234 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 06:34:30.287531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 06:34:30.287899) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 06:34:30.288228) ========= ========= Total master_lag: 0.20 =========