builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0378 starttime: 1467462561.22 results: success (0) buildid: 20160702030219 builduid: 5e94ce95d87542d69b9e698cb6a7d425 revision: 39dffbba764210b25bfc1e749b4f16db77fa0d46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:21.218232) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:21.218629) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:21.218955) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:21.269544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:21.269859) ========= 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.gXG28HrwsX/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.iEzRDHzMUT/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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-02 05:29:21-- 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.50M=0.001s 2016-07-02 05:29:21 (8.50 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152533 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:21.450492) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:21.451343) ========= 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.gXG28HrwsX/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.iEzRDHzMUT/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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.018978 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:21.514317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:21.515126) ========= 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.gXG28HrwsX/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.iEzRDHzMUT/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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-02 05:29:21,591 truncating revision to first 12 chars 2016-07-02 05:29:21,591 Setting DEBUG logging. 2016-07-02 05:29:21,591 attempt 1/10 2016-07-02 05:29:21,591 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-02 05:29:21,921 unpacking tar archive at: mozilla-central-39dffbba7642/testing/mozharness/ program finished with exit code 0 elapsedTime=0.605951 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:22.150226) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:22.150574) ========= script_repo_revision: 39dffbba764210b25bfc1e749b4f16db77fa0d46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:22.151005) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:22.151316) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:22.178034) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 7 secs) (at 2016-07-02 05:29:22.178357) ========= /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.gXG28HrwsX/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.iEzRDHzMUT/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:29:22 INFO - MultiFileLogger online at 20160702 05:29:22 in /builds/slave/test 05:29:22 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 05:29:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:22 INFO - {'append_to_log': False, 05:29:22 INFO - 'base_work_dir': '/builds/slave/test', 05:29:22 INFO - 'blob_upload_branch': 'Firefox', 05:29:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:22 INFO - 'branch': 'Firefox', 05:29:22 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:22 INFO - 'config_files': ('talos/mac_config.py',), 05:29:22 INFO - 'default_actions': ('clobber', 05:29:22 INFO - 'read-buildbot-config', 05:29:22 INFO - 'download-and-extract', 05:29:22 INFO - 'populate-webroot', 05:29:22 INFO - 'create-virtualenv', 05:29:22 INFO - 'install', 05:29:22 INFO - 'run-tests'), 05:29:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:22 INFO - 'download_minidump_stackwalk': True, 05:29:22 INFO - 'download_symbols': 'ondemand', 05:29:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:22 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:22 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:22 INFO - 'installer_path': 'installer.exe', 05:29:22 INFO - 'log_level': 'info', 05:29:22 INFO - 'log_name': 'talos', 05:29:22 INFO - 'log_to_console': True, 05:29:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:29:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:29:22 INFO - 'opt_config_files': (), 05:29:22 INFO - 'pip_index': False, 05:29:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:22 INFO - 'cmd': ('bash', 05:29:22 INFO - '-c', 05:29:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:22 INFO - 'enabled': True, 05:29:22 INFO - 'halt_on_failure': False, 05:29:22 INFO - 'name': 'check_screen_resolution'},), 05:29:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:22 INFO - 'cmd': ('bash', 05:29:22 INFO - '-c', 05:29:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:22 INFO - 'enabled': True, 05:29:22 INFO - 'halt_on_failure': False, 05:29:22 INFO - 'name': 'check_screen_resolution'},), 05:29:22 INFO - 'run_cmd_checks_enabled': True, 05:29:22 INFO - 'sps_profile': False, 05:29:22 INFO - 'sps_profile_interval': 0, 05:29:22 INFO - 'suite': 'dromaeojs', 05:29:22 INFO - 'system_bits': '32', 05:29:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:22 INFO - 'title': 't-yosemite-r7-0378', 05:29:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:22 INFO - 'use_talos_json': True, 05:29:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:22 INFO - 'work_dir': 'build'} 05:29:22 INFO - ##### 05:29:22 INFO - ##### Running clobber step. 05:29:22 INFO - ##### 05:29:22 INFO - Running pre-action listener: _resource_record_pre_action 05:29:22 INFO - Running main action method: clobber 05:29:22 INFO - rmtree: /builds/slave/test/build 05:29:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:22 INFO - Running post-action listener: _resource_record_post_action 05:29:22 INFO - ##### 05:29:22 INFO - ##### Finished clobber step (success) 05:29:22 INFO - ##### 05:29:22 INFO - ##### 05:29:22 INFO - ##### Running read-buildbot-config step. 05:29:22 INFO - ##### 05:29:22 INFO - Running pre-action listener: _resource_record_pre_action 05:29:22 INFO - Running main action method: read_buildbot_config 05:29:22 INFO - Using buildbot properties: 05:29:22 INFO - { 05:29:22 INFO - "project": "", 05:29:22 INFO - "product": "firefox", 05:29:22 INFO - "script_repo_revision": "production", 05:29:22 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:29:22 INFO - "repository": "", 05:29:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:29:22 INFO - "buildid": "20160702030219", 05:29:22 INFO - "stage_platform": "macosx64", 05:29:22 INFO - "basedir": "/builds/slave/test", 05:29:22 INFO - "nightly_build": "True", 05:29:22 INFO - "buildnumber": 37, 05:29:22 INFO - "slavename": "t-yosemite-r7-0378", 05:29:22 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:29:22 INFO - "platform": "yosemite_r7", 05:29:22 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:29:22 INFO - "branch": "mozilla-central", 05:29:22 INFO - "repo_path": "mozilla-central", 05:29:22 INFO - "revision": "39dffbba764210b25bfc1e749b4f16db77fa0d46", 05:29:22 INFO - "pgo_build": "False", 05:29:22 INFO - "builduid": "5e94ce95d87542d69b9e698cb6a7d425", 05:29:22 INFO - "slavebuilddir": "test" 05:29:22 INFO - } 05:29:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 05:29:22 INFO - Running post-action listener: _resource_record_post_action 05:29:22 INFO - ##### 05:29:22 INFO - ##### Finished read-buildbot-config step (success) 05:29:22 INFO - ##### 05:29:22 INFO - ##### 05:29:22 INFO - ##### Running download-and-extract step. 05:29:22 INFO - ##### 05:29:22 INFO - Running pre-action listener: _resource_record_pre_action 05:29:22 INFO - Running main action method: download_and_extract 05:29:22 INFO - mkdir: /builds/slave/test/build/tests 05:29:22 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')]} 05:29:22 INFO - https://queue.taskcluster.net/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:29:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:29:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:29:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/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 05:29:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/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 05:29:52 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 05:29:52 INFO - retry: attempt #1 caught exception: timed out 05:29:52 INFO - retry: Failed, sleeping 30 seconds before retrying 05:30:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/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 #2 05:30:23 INFO - Downloaded 1199 bytes. 05:30:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 05:30:23 INFO - Using the following test package requirements: 05:30:23 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:30:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:30:23 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 05:30:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:30:23 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 05:30:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:30:23 INFO - u'jsshell-mac.zip'], 05:30:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:30:23 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 05:30:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:30:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:30:23 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 05:30:23 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:30:23 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 05:30:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:30:23 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 05:30:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:30:23 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 05:30:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:30: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')]} 05:30:23 INFO - https://queue.taskcluster.net/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:30:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:30:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:30:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/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 05:30:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/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 05:30:24 INFO - Downloaded 18791467 bytes. 05:30:24 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'] 05:30:24 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 05:30:27 INFO - Return code: 0 05:30:27 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 05:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:27 INFO - https://queue.taskcluster.net/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:30:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:30:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:30:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/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 05:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/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 05:30:31 INFO - Downloaded 18791467 bytes. 05:30:31 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'] 05:30:31 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 05:30:35 INFO - Return code: 0 05:30:35 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')]} 05:30:35 INFO - https://queue.taskcluster.net/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:30:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:30:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:30:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/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 05:30:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/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 05:30:36 INFO - Downloaded 14405327 bytes. 05:30:36 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'] 05:30:36 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 05:30:36 INFO - Return code: 0 05:30: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')]} 05:30:36 INFO - https://queue.taskcluster.net/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:30:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:30:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:30:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 05:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXBSOjAuT9GDcyHm1KxAdw/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 05:30:39 INFO - Downloaded 112575458 bytes. 05:30:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:30:39 INFO - mkdir: /builds/slave/test/properties 05:30:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:30:39 INFO - Writing to file /builds/slave/test/properties/build_url 05:30:39 INFO - Contents: 05:30:39 INFO - build_url:https://queue.taskcluster.net/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:30:40 INFO - Running post-action listener: _resource_record_post_action 05:30:40 INFO - Running post-action listener: set_extra_try_arguments 05:30:40 INFO - ##### 05:30:40 INFO - ##### Finished download-and-extract step (success) 05:30:40 INFO - ##### 05:30:40 INFO - ##### 05:30:40 INFO - ##### Running populate-webroot step. 05:30:40 INFO - ##### 05:30:40 INFO - Running pre-action listener: _resource_record_pre_action 05:30:40 INFO - Running main action method: populate_webroot 05:30:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:30:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:30:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:30:40 INFO - '--tppagecycles', 05:30:40 INFO - '7'], 05:30:40 INFO - 'tests': ['tsvgm']}}, 05:30:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:30:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:30:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:30:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:30:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:30:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:40 INFO - 'talos_options': ['--disable-e10s'], 05:30:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:40 INFO - 'talos_options': ['--disable-e10s'], 05:30:40 INFO - 'tests': ['damp', 'tps']}, 05:30:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:40 INFO - 'tests': ['damp', 'tps']}, 05:30:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:30:40 INFO - 'tests': ['dromaeo_dom']}, 05:30:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:30:40 INFO - 'tests': ['basic_compositor_video']}, 05:30:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:30:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:30:40 INFO - 'tests': ['a11yr', 05:30:40 INFO - 'ts_paint', 05:30:40 INFO - 'tpaint', 05:30:40 INFO - 'sessionrestore', 05:30:40 INFO - 'sessionrestore_no_auto_restore', 05:30:40 INFO - 'tabpaint']}, 05:30:40 INFO - 'other-e10s': {'tests': ['a11yr', 05:30:40 INFO - 'ts_paint', 05:30:40 INFO - 'tpaint', 05:30:40 INFO - 'sessionrestore', 05:30:40 INFO - 'sessionrestore_no_auto_restore', 05:30:40 INFO - 'tabpaint']}, 05:30:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:30:40 INFO - 'ts_paint', 05:30:40 INFO - 'tpaint', 05:30:40 INFO - 'sessionrestore', 05:30:40 INFO - 'sessionrestore_no_auto_restore', 05:30:40 INFO - 'tabpaint']}, 05:30:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:30:40 INFO - 'ts_paint', 05:30:40 INFO - 'tpaint', 05:30:41 INFO - 'sessionrestore', 05:30:41 INFO - 'sessionrestore_no_auto_restore', 05:30:41 INFO - 'tabpaint']}, 05:30:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:30:41 INFO - 'tests': ['a11yr', 05:30:41 INFO - 'ts_paint', 05:30:41 INFO - 'tpaint', 05:30:41 INFO - 'sessionrestore', 05:30:41 INFO - 'sessionrestore_no_auto_restore', 05:30:41 INFO - 'tabpaint']}, 05:30:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:30:41 INFO - 'tests': ['a11yr', 05:30:41 INFO - 'ts_paint', 05:30:41 INFO - 'tpaint', 05:30:41 INFO - 'sessionrestore', 05:30:41 INFO - 'sessionrestore_no_auto_restore', 05:30:41 INFO - 'tabpaint']}, 05:30:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:30:41 INFO - 'tests': ['tsvgx', 05:30:41 INFO - 'tsvgr_opacity', 05:30:41 INFO - 'tart', 05:30:41 INFO - 'tscrollx', 05:30:41 INFO - 'cart']}, 05:30:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:30:41 INFO - 'tsvgr_opacity', 05:30:41 INFO - 'tart', 05:30:41 INFO - 'tscrollx', 05:30:41 INFO - 'cart']}, 05:30:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:41 INFO - 'talos_options': ['--disable-e10s'], 05:30:41 INFO - 'tests': ['tp5o']}, 05:30:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:41 INFO - 'tests': ['tp5o']}, 05:30:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:41 INFO - 'talos_options': ['--disable-e10s', 05:30:41 INFO - '--xperf_path', 05:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:41 INFO - 'tests': ['tp5n']}, 05:30:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:41 INFO - 'talos_options': ['--xperf_path', 05:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:41 INFO - 'tests': ['tp5n']}}, 05:30:41 INFO - 'talos.zip': {'path': '', 05:30:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:30:41 INFO - Running post-action listener: _resource_record_post_action 05:30:41 INFO - ##### 05:30:41 INFO - ##### Finished populate-webroot step (success) 05:30:41 INFO - ##### 05:30:41 INFO - ##### 05:30:41 INFO - ##### Running create-virtualenv step. 05:30:41 INFO - ##### 05:30:41 INFO - Running pre-action listener: _resource_record_pre_action 05:30:41 INFO - Running main action method: create_virtualenv 05:30:41 INFO - Creating virtualenv /builds/slave/test/build/venv 05:30:41 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 05:30:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:30:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:41 INFO - Using real prefix '/tools/python27' 05:30:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:30:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:44 INFO - Installing pip.................done. 05:30:44 INFO - Return code: 0 05:30:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:44 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 0x106c55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cea618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed5967cd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9d30>, '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 0x10691edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1b20>, '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.gXG28HrwsX/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.iEzRDHzMUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:30:44 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 05:30:44 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 05:30:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXG28HrwsX/Render', 05:30:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:44 INFO - 'HOME': '/Users/cltbld', 05:30:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:44 INFO - 'LOGNAME': 'cltbld', 05:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:44 INFO - 'MOZ_NO_REMOTE': '1', 05:30:44 INFO - 'NO_EM_RESTART': '1', 05:30:44 INFO - 'PAGER': '/bin/cat', 05:30:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:44 INFO - 'PWD': '/builds/slave/test', 05:30:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:44 INFO - 'SHELL': '/bin/bash', 05:30:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iEzRDHzMUT/Listeners', 05:30:44 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:30:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:44 INFO - 'USER': 'cltbld', 05:30:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:44 INFO - 'XPC_FLAGS': '0x0', 05:30:44 INFO - 'XPC_SERVICE_NAME': '0', 05:30:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:44 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 05:30:44 INFO - Cleaning up... 05:30:44 INFO - Return code: 0 05:30:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:44 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 0x106c55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cea618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed5967cd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9d30>, '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 0x10691edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1b20>, '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.gXG28HrwsX/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.iEzRDHzMUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:30:44 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 05:30:44 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 05:30:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXG28HrwsX/Render', 05:30:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:44 INFO - 'HOME': '/Users/cltbld', 05:30:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:44 INFO - 'LOGNAME': 'cltbld', 05:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:44 INFO - 'MOZ_NO_REMOTE': '1', 05:30:44 INFO - 'NO_EM_RESTART': '1', 05:30:44 INFO - 'PAGER': '/bin/cat', 05:30:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:44 INFO - 'PWD': '/builds/slave/test', 05:30:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:44 INFO - 'SHELL': '/bin/bash', 05:30:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iEzRDHzMUT/Listeners', 05:30:44 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:30:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:44 INFO - 'USER': 'cltbld', 05:30:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:44 INFO - 'XPC_FLAGS': '0x0', 05:30:44 INFO - 'XPC_SERVICE_NAME': '0', 05:30:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:45 INFO - Downloading/unpacking psutil>=3.1.1 05:30:45 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 05:30:45 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 05:30:45 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 05:30:45 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 05:30:45 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 05:30:45 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 05:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:30:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:48 INFO - Installing collected packages: psutil 05:30:48 INFO - Running setup.py install for psutil 05:30:48 INFO - building 'psutil._psutil_osx' extension 05:30:48 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 05:30:48 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 05:30:48 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 05:30:48 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 05:30:48 INFO - building 'psutil._psutil_posix' extension 05:30:48 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 05:30:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:30:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:30:48 INFO - ^ 05:30:48 INFO - 1 warning generated. 05:30:48 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 05:30:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:49 INFO - Successfully installed psutil 05:30:49 INFO - Cleaning up... 05:30:49 INFO - Return code: 0 05:30:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cea618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed5967cd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9d30>, '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 0x10691edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1b20>, '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.gXG28HrwsX/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.iEzRDHzMUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:30:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:30:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXG28HrwsX/Render', 05:30:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:49 INFO - 'HOME': '/Users/cltbld', 05:30:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:49 INFO - 'LOGNAME': 'cltbld', 05:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:49 INFO - 'MOZ_NO_REMOTE': '1', 05:30:49 INFO - 'NO_EM_RESTART': '1', 05:30:49 INFO - 'PAGER': '/bin/cat', 05:30:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:49 INFO - 'PWD': '/builds/slave/test', 05:30:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:49 INFO - 'SHELL': '/bin/bash', 05:30:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iEzRDHzMUT/Listeners', 05:30:49 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:30:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:49 INFO - 'USER': 'cltbld', 05:30:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:49 INFO - 'XPC_FLAGS': '0x0', 05:30:49 INFO - 'XPC_SERVICE_NAME': '0', 05:30:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:30:52 INFO - Installing collected packages: mozsystemmonitor 05:30:52 INFO - Running setup.py install for mozsystemmonitor 05:30:52 INFO - Successfully installed mozsystemmonitor 05:30:52 INFO - Cleaning up... 05:30:52 INFO - Return code: 0 05:30:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106c55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cea618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed5967cd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9d30>, '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 0x10691edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1b20>, '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.gXG28HrwsX/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.iEzRDHzMUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:30:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXG28HrwsX/Render', 05:30:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:52 INFO - 'HOME': '/Users/cltbld', 05:30:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:52 INFO - 'LOGNAME': 'cltbld', 05:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:52 INFO - 'MOZ_NO_REMOTE': '1', 05:30:52 INFO - 'NO_EM_RESTART': '1', 05:30:52 INFO - 'PAGER': '/bin/cat', 05:30:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:52 INFO - 'PWD': '/builds/slave/test', 05:30:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:52 INFO - 'SHELL': '/bin/bash', 05:30:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iEzRDHzMUT/Listeners', 05:30:52 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:30:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:52 INFO - 'USER': 'cltbld', 05:30:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:52 INFO - 'XPC_FLAGS': '0x0', 05:30:52 INFO - 'XPC_SERVICE_NAME': '0', 05:30:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:52 INFO - Downloading/unpacking jsonschema==2.5.1 05:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:30:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:30:55 INFO - warning: no files found matching '*.txt' 05:30:55 INFO - no previously-included directories found matching 'build' 05:30:55 INFO - no previously-included directories found matching 'dist' 05:30:55 INFO - no previously-included directories found matching '.git*' 05:30:55 INFO - Installing collected packages: jsonschema, functools32 05:30:55 INFO - Running setup.py install for functools32 05:30:55 INFO - warning: no files found matching '*.txt' 05:30:55 INFO - no previously-included directories found matching 'build' 05:30:55 INFO - no previously-included directories found matching 'dist' 05:30:55 INFO - no previously-included directories found matching '.git*' 05:30:55 INFO - Successfully installed jsonschema functools32 05:30:55 INFO - Cleaning up... 05:30:55 INFO - Return code: 0 05:30:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:30:55 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')]} 05:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:55 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')]} 05:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:55 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 0x106c55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cea618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed5967cd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9d30>, '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 0x10691edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1b20>, '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.gXG28HrwsX/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.iEzRDHzMUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:30:55 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 05:30:55 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 05:30:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXG28HrwsX/Render', 05:30:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:55 INFO - 'HOME': '/Users/cltbld', 05:30:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:55 INFO - 'LOGNAME': 'cltbld', 05:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:55 INFO - 'MOZ_NO_REMOTE': '1', 05:30:55 INFO - 'NO_EM_RESTART': '1', 05:30:55 INFO - 'PAGER': '/bin/cat', 05:30:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:55 INFO - 'PWD': '/builds/slave/test', 05:30:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:55 INFO - 'SHELL': '/bin/bash', 05:30:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iEzRDHzMUT/Listeners', 05:30:55 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:30:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:55 INFO - 'USER': 'cltbld', 05:30:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:55 INFO - 'XPC_FLAGS': '0x0', 05:30:55 INFO - 'XPC_SERVICE_NAME': '0', 05:30:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:55 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:58 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 05:30:58 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 05:30:58 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 05:30:58 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 05:30:58 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 05:30:58 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 05:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:30:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:59 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 05:30:59 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 05:30:59 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 05:30:59 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 05:30:59 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 05:30:59 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 05:30:59 INFO - Downloading docopt-0.6.1.tar.gz 05:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:59 INFO - Running setup.py install for blobuploader 05:30:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:30:59 INFO - Running setup.py install for requests 05:31:00 INFO - Running setup.py install for docopt 05:31:00 INFO - Successfully installed blobuploader requests docopt 05:31:00 INFO - Cleaning up... 05:31:00 INFO - Return code: 0 05:31:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:00 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 0x106c55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cea618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed5967cd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9d30>, '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 0x10691edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1b20>, '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.gXG28HrwsX/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.iEzRDHzMUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:31:00 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 05:31:00 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 05:31:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXG28HrwsX/Render', 05:31:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:00 INFO - 'HOME': '/Users/cltbld', 05:31:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:00 INFO - 'LOGNAME': 'cltbld', 05:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:00 INFO - 'MOZ_NO_REMOTE': '1', 05:31:00 INFO - 'NO_EM_RESTART': '1', 05:31:00 INFO - 'PAGER': '/bin/cat', 05:31:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:00 INFO - 'PWD': '/builds/slave/test', 05:31:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:00 INFO - 'SHELL': '/bin/bash', 05:31:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iEzRDHzMUT/Listeners', 05:31:00 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:31:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:00 INFO - 'USER': 'cltbld', 05:31:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:00 INFO - 'XPC_FLAGS': '0x0', 05:31:00 INFO - 'XPC_SERVICE_NAME': '0', 05:31:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:31:00 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-3RwZGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:31:00 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-nCrmS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:31:00 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-jRtSsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:31:01 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-7wSOOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:31:01 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-d1CRmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:31:01 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-QJTofN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:31:01 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-kBPr3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:31:01 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-uTWK3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:31:01 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-hJjBip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:31:01 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-jXMBR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:31:01 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-PeMpZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:31:01 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-TcJu1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:31:02 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-3aPNWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:31:02 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-DBwVEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:02 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-eVC5Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:31:02 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-oLbCXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:31:02 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-hYBPpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:31:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:31:02 INFO - Running setup.py install for manifestparser 05:31:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:31:02 INFO - Running setup.py install for mozcrash 05:31:02 INFO - Running setup.py install for mozdebug 05:31:02 INFO - Running setup.py install for mozdevice 05:31:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:31:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:31:03 INFO - Running setup.py install for mozfile 05:31:03 INFO - Running setup.py install for mozhttpd 05:31:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:31:03 INFO - Running setup.py install for mozinfo 05:31:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:31:03 INFO - Running setup.py install for mozInstall 05:31:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:31:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:31:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:31:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:31:03 INFO - Running setup.py install for mozleak 05:31:03 INFO - Running setup.py install for mozlog 05:31:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:31:04 INFO - Running setup.py install for moznetwork 05:31:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:31:04 INFO - Running setup.py install for mozprocess 05:31:04 INFO - Running setup.py install for mozprofile 05:31:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:31:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:31:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:31:04 INFO - Running setup.py install for mozrunner 05:31:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:31:04 INFO - Running setup.py install for mozscreenshot 05:31:04 INFO - Running setup.py install for moztest 05:31:04 INFO - Running setup.py install for mozversion 05:31:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:31:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:31:05 INFO - Cleaning up... 05:31:05 INFO - Return code: 0 05:31:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:05 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')]} 05:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:05 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')]} 05:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:05 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 0x106c55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cea618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed5967cd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9d30>, '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 0x10691edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1b20>, '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.gXG28HrwsX/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.iEzRDHzMUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:31:05 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 05:31:05 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 05:31:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXG28HrwsX/Render', 05:31:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:05 INFO - 'HOME': '/Users/cltbld', 05:31:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:05 INFO - 'LOGNAME': 'cltbld', 05:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:05 INFO - 'MOZ_NO_REMOTE': '1', 05:31:05 INFO - 'NO_EM_RESTART': '1', 05:31:05 INFO - 'PAGER': '/bin/cat', 05:31:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:05 INFO - 'PWD': '/builds/slave/test', 05:31:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:05 INFO - 'SHELL': '/bin/bash', 05:31:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iEzRDHzMUT/Listeners', 05:31:05 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:31:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:05 INFO - 'USER': 'cltbld', 05:31:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:05 INFO - 'XPC_FLAGS': '0x0', 05:31:05 INFO - 'XPC_SERVICE_NAME': '0', 05:31:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:31:05 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-LwFXad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:31:05 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)) 05:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:31:05 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-bgNYjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:31:05 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)) 05:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:31:05 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-PT2ln0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:31:05 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)) 05:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:31:05 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-cTKJJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:31:05 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)) 05:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:31:05 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-Fp5_sN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:31:05 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)) 05:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:31:05 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-bp1Z5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:31:06 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)) 05:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:31:06 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-0rBgFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:31:06 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)) 05:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:31:06 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-dwX6Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:31:06 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)) 05:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:31:06 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-TwQxSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:31:06 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)) 05:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:31:06 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-GNoBrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:31:06 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)) 05:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:31:06 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-I2FeyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:31:06 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)) 05:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:31:06 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-npacwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:31:06 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)) 05:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:31:06 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-pr5RHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:31:06 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)) 05:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:31:06 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-jq6bGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:31:06 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)) 05:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:06 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-uyQvXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:07 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)) 05:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:31:07 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-JEtclC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:31:07 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)) 05:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:31:07 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-YVkcSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:31:07 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)) 05:31:07 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)) 05:31:07 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)) 05:31:07 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)) 05:31:07 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)) 05:31:07 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)) 05:31:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:09 INFO - Downloading blessings-1.6.tar.gz 05:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:31:09 INFO - Installing collected packages: blessings 05:31:09 INFO - Running setup.py install for blessings 05:31:09 INFO - Successfully installed blessings 05:31:09 INFO - Cleaning up... 05:31:10 INFO - Return code: 0 05:31:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:31:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:31:10 INFO - Reading from file tmpfile_stdout 05:31:10 INFO - Current package versions: 05:31:10 INFO - blessings == 1.6 05:31:10 INFO - blobuploader == 1.2.4 05:31:10 INFO - docopt == 0.6.1 05:31:10 INFO - functools32 == 3.2.3-2 05:31:10 INFO - jsonschema == 2.5.1 05:31:10 INFO - manifestparser == 1.1 05:31:10 INFO - mozInstall == 1.12 05:31:10 INFO - mozcrash == 0.17 05:31:10 INFO - mozdebug == 0.1 05:31:10 INFO - mozdevice == 0.48 05:31:10 INFO - mozfile == 1.2 05:31:10 INFO - mozhttpd == 0.7 05:31:10 INFO - mozinfo == 0.9 05:31:10 INFO - mozleak == 0.1 05:31:10 INFO - mozlog == 3.2 05:31:10 INFO - moznetwork == 0.27 05:31:10 INFO - mozprocess == 0.22 05:31:10 INFO - mozprofile == 0.28 05:31:10 INFO - mozrunner == 6.11 05:31:10 INFO - mozscreenshot == 0.1 05:31:10 INFO - mozsystemmonitor == 0.3 05:31:10 INFO - moztest == 0.7 05:31:10 INFO - mozversion == 1.4 05:31:10 INFO - psutil == 3.1.1 05:31:10 INFO - requests == 1.2.3 05:31:10 INFO - wsgiref == 0.1.2 05:31:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:10 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')]} 05:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:10 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')]} 05:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:10 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 0x106c55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cea618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed5967cd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9d30>, '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 0x10691edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1b20>, '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.gXG28HrwsX/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.iEzRDHzMUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:31:10 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 05:31:10 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 05:31:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXG28HrwsX/Render', 05:31:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:10 INFO - 'HOME': '/Users/cltbld', 05:31:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:10 INFO - 'LOGNAME': 'cltbld', 05:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:10 INFO - 'MOZ_NO_REMOTE': '1', 05:31:10 INFO - 'NO_EM_RESTART': '1', 05:31:10 INFO - 'PAGER': '/bin/cat', 05:31:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:10 INFO - 'PWD': '/builds/slave/test', 05:31:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:10 INFO - 'SHELL': '/bin/bash', 05:31:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iEzRDHzMUT/Listeners', 05:31:10 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:31:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:10 INFO - 'USER': 'cltbld', 05:31:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:10 INFO - 'XPC_FLAGS': '0x0', 05:31:10 INFO - 'XPC_SERVICE_NAME': '0', 05:31:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:10 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)) 05:31:10 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)) 05:31:10 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)) 05:31:10 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)) 05:31:10 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)) 05:31:10 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)) 05:31:10 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)) 05:31:10 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)) 05:31:10 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)) 05:31:10 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)) 05:31:10 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)) 05:31:10 INFO - Cleaning up... 05:31:10 INFO - Return code: 0 05:31:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:31:10 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')]} 05:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:10 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')]} 05:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:10 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 0x106c55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cea618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed5967cd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb9d30>, '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 0x10691edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1b20>, '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.gXG28HrwsX/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.iEzRDHzMUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:31:10 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 05:31:10 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 05:31:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXG28HrwsX/Render', 05:31:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:10 INFO - 'HOME': '/Users/cltbld', 05:31:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:10 INFO - 'LOGNAME': 'cltbld', 05:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:10 INFO - 'MOZ_NO_REMOTE': '1', 05:31:10 INFO - 'NO_EM_RESTART': '1', 05:31:10 INFO - 'PAGER': '/bin/cat', 05:31:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:10 INFO - 'PWD': '/builds/slave/test', 05:31:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:10 INFO - 'SHELL': '/bin/bash', 05:31:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iEzRDHzMUT/Listeners', 05:31:10 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:31:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:10 INFO - 'USER': 'cltbld', 05:31:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:10 INFO - 'XPC_FLAGS': '0x0', 05:31:10 INFO - 'XPC_SERVICE_NAME': '0', 05:31:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:31:10 INFO - Cleaning up... 05:31:10 INFO - Return code: 0 05:31:10 INFO - Running post-action listener: _resource_record_post_action 05:31:10 INFO - Running post-action listener: _start_resource_monitoring 05:31:10 INFO - Starting resource monitoring. 05:31:10 INFO - ##### 05:31:10 INFO - ##### Finished create-virtualenv step (success) 05:31:10 INFO - ##### 05:31:10 INFO - ##### 05:31:10 INFO - ##### Running install step. 05:31:10 INFO - ##### 05:31:10 INFO - Running pre-action listener: _resource_record_pre_action 05:31:10 INFO - Running main action method: install 05:31:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:31:11 INFO - Reading from file tmpfile_stdout 05:31:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:31:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:31:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:31:11 INFO - Reading from file tmpfile_stdout 05:31:11 INFO - Output received: 05:31:11 INFO - Usage: mozinstall [options] installer 05:31:11 INFO - Options: 05:31:11 INFO - -h, --help show this help message and exit 05:31:11 INFO - -d DEST, --destination=DEST 05:31:11 INFO - Directory to install application into. [default: 05:31:11 INFO - "/builds/slave/test"] 05:31:11 INFO - --app=APP Application being installed. [default: firefox] 05:31:11 INFO - mkdir: /builds/slave/test/build/application 05:31:11 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'] 05:31:11 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 05:31:46 INFO - Reading from file tmpfile_stdout 05:31:46 INFO - Output received: 05:31:46 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:31:46 INFO - Running post-action listener: _resource_record_post_action 05:31:46 INFO - ##### 05:31:46 INFO - ##### Finished install step (success) 05:31:46 INFO - ##### 05:31:46 INFO - ##### 05:31:46 INFO - ##### Running run-tests step. 05:31:46 INFO - ##### 05:31:46 INFO - Running pre-action listener: _resource_record_pre_action 05:31:46 INFO - Running main action method: run_tests 05:31:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:31:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:31:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:31:46 INFO - 2016-07-02 05:31:46.243 screenresolution[2000:279611] starting screenresolution argv=screenresolution get 05:31:46 INFO - 2016-07-02 05:31:46.245 screenresolution[2000:279611] Display 0: 1600x1200x32@60 05:31:46 INFO - 2016-07-02 05:31:46.250 screenresolution[2001:279614] starting screenresolution argv=screenresolution list 05:31:46 INFO - Available Modes on Display 0 05:31:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:31:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:31:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:31:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:31:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:31:46 INFO - Intel Iris: 05:31:46 INFO - Chipset Model: Intel Iris 05:31:46 INFO - Type: GPU 05:31:46 INFO - Bus: Built-In 05:31:46 INFO - VRAM (Dynamic, Max): 1536 MB 05:31:46 INFO - Vendor: Intel (0x8086) 05:31:46 INFO - Device ID: 0x0a2e 05:31:46 INFO - Revision ID: 0x0009 05:31:46 INFO - Displays: 05:31:46 INFO - Display: 05:31:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:31:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:31:46 INFO - Display Serial Number: 1600x1200 60 05:31:46 INFO - Main Display: Yes 05:31:46 INFO - Mirror: Off 05:31:46 INFO - Online: Yes 05:31:46 INFO - Rotation: Supported 05:31:46 INFO - Return code: 0 05:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:31:46 INFO - Python 2.7.3 05:31:46 INFO - Return code: 0 05:31:46 INFO - grabbing minidump binary from tooltool 05:31: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')]} 05:31:46 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 0x106bb9d30>, '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 0x10691edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:31:46 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 05:31:46 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 05:31:46 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 05:31:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:31:46 INFO - Return code: 0 05:31:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:31:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:31:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:31:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:31:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:31:46 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/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0378', '--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 05:31:46 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/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0378 --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 05:31:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXG28HrwsX/Render', 05:31:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:46 INFO - 'HOME': '/Users/cltbld', 05:31:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:46 INFO - 'LOGNAME': 'cltbld', 05:31:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:31:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:46 INFO - 'MOZ_NO_REMOTE': '1', 05:31:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:31:46 INFO - 'NO_EM_RESTART': '1', 05:31:46 INFO - 'PAGER': '/bin/cat', 05:31:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:46 INFO - 'PWD': '/builds/slave/test', 05:31:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:31:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:46 INFO - 'SHELL': '/bin/bash', 05:31:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iEzRDHzMUT/Listeners', 05:31:46 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:31:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:46 INFO - 'USER': 'cltbld', 05:31:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:46 INFO - 'XPC_FLAGS': '0x0', 05:31:46 INFO - 'XPC_SERVICE_NAME': '0', 05:31:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:46 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/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0378', '--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 05:31:46 INFO - mozversion application_buildid: 20160702030219 05:31:46 INFO - mozversion application_changeset: 39dffbba764210b25bfc1e749b4f16db77fa0d46 05:31:46 INFO - mozversion application_display_name: Nightly 05:31:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:31:46 INFO - mozversion application_name: Firefox 05:31:46 INFO - mozversion application_remotingname: firefox 05:31:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:31:46 INFO - mozversion application_vendor: Mozilla 05:31:46 INFO - mozversion application_version: 50.0a1 05:31:46 INFO - mozversion platform_buildid: 20160702030219 05:31:46 INFO - mozversion platform_changeset: 39dffbba764210b25bfc1e749b4f16db77fa0d46 05:31:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:31:46 INFO - mozversion platform_version: 50.0a1 05:31:46 INFO - using testdate: 1467462706 05:31:46 INFO - actual date: 1467462706 05:31:46 INFO - starting webserver on 'localhost:49376' 05:31:46 INFO - SUITE-START | Running 2 tests 05:31:46 INFO - TEST-START | dromaeo_css 05:31:46 INFO - operating with platform_type : mac_ 05:31:46 INFO - Initialising browser for dromaeo_css test... 05:31:46 INFO - TEST-INFO | started process 2011 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmptEdy8_/profile http://localhost:49376/getInfo.html) 05:31:49 INFO - PROCESS | 2011 | __metrics Screen width/height:1600/1200 05:31:49 INFO - PROCESS | 2011 | colorDepth:24 05:31:49 INFO - PROCESS | 2011 | Browser inner width/height: 1024/689 05:31:49 INFO - PROCESS | 2011 | __metrics 05:31:49 INFO - PROCESS | 2011 | 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" 05:31:49 INFO - PROCESS | 2011 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:50 INFO - TEST-INFO | 2011: exit 0 05:31:50 INFO - Browser initialized. 05:31:50 INFO - Running cycle 1/1 for dromaeo_css test... 05:31:50 INFO - TEST-INFO | started process 2016 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmptEdy8_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:02 INFO - PROCESS | 2016 | RSS: Main: 243695616 05:32:02 INFO - PROCESS | 2016 | 05:32:53 INFO - PROCESS | 2016 | 1467462773881 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] 05:35:04 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49376/tests/dromaeo/cssquery-ext.html) 05:35:05 INFO - PROCESS | 2016 | RSS: Main: 343904256 05:35:05 INFO - PROCESS | 2016 | 05:38:08 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-ext.html (next: http://localhost:49376/tests/dromaeo/cssquery-jquery.html) 05:38:09 INFO - PROCESS | 2016 | RSS: Main: 379682816 05:38:09 INFO - PROCESS | 2016 | 05:41:11 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49376/tests/dromaeo/cssquery-mootools.html) 05:41:12 INFO - PROCESS | 2016 | RSS: Main: 368422912 05:41:12 INFO - PROCESS | 2016 | 05:44:14 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49376/tests/dromaeo/cssquery-prototype.html) 05:44:15 INFO - PROCESS | 2016 | RSS: Main: 371511296 05:44:15 INFO - PROCESS | 2016 | 05:47:18 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49376/tests/dromaeo/cssquery-yui.html) 05:47:19 INFO - PROCESS | 2016 | RSS: Main: 334602240 05:47:19 INFO - PROCESS | 2016 | 05:50:21 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-yui.html (next: http://localhost:49376/tests/dromaeo/cssquery-dojo.html) 05:50:22 INFO - PROCESS | 2016 | RSS: Main: 388374528 05:50:22 INFO - PROCESS | 2016 | 05:50:22 INFO - PROCESS | 2016 | __start_tp_report 05:50:22 INFO - PROCESS | 2016 | _x_x_mozilla_page_load 05:50:22 INFO - PROCESS | 2016 | _x_x_mozilla_page_load_details 05:50:22 INFO - PROCESS | 2016 | |i|pagename|runs| 05:50:22 INFO - PROCESS | 2016 | |0;dojo.html;3327.1016825457127;3352.631210566837;3376.358491886541;3385.2213990782134;3422.4181889078855;5606.046972014768;5666.348369937453;5673.26247587813;5731.226284451598;5766.625169363993;5648.887022259552;5697.03150464422;5794.478496935286;5808.099744539592;5822.737976791044;5066.41736200338;5081.898362032757;5152.304438900738;5159.690418574879;5242.423333433319;5195.792168313263;5228.895422091556;5261.342332208474;5263.631545791796;5291.417944026154;5082.415522214956;5095.949040509585;5109.054824857413;5120.692758434506;5155.304033955405;5097.184450487941;5129.615278854101;5130.102232109366;5229.581633469314;5243.161094224905;5092.7453627318855;5166.405863325728;5167.9224811627855;5175.45657705943;5231.843044708665;5601.971990140064;5707.6575405475805;5735.856603584902;5757.884842303172;5803.5357171426185;6056.2729940271365;6112.807455516543;6137.7447333336595;6151.846203844895;6212.285587157489;6248.9062664060075;6268.216472940882;6305.873882522324;6312.621242725405;6328.588641738273;5657.349404818417;5755.6834374108985;5769.076947688392;5811.186433899257;5838.357780644125;6248.156498872594;6298.622082675054;6306.24325080984;6306.8423289417215;6321.8735625288155;6136.969315153396;6161.137440758297;6168.907466388007;6174.475169610543;6175.3824617538785;6094.471245618374;6222.81331560054;6301.306856245809;6325;6335.11308416822;5233.215017747369;6104.511639068864;6133.548895741652;6151.815445536641;6181.536384771161;6210.161628180228;6218.844528886814;6222.533310001678;6224.346443623354;6241.282252541016;4862.367892173995;4863.9785645014235;4867.34290870735;4886.120498310338;4918.065567542156;4354.521002689701;4364.279893817548;4376.256036473807;4399.472063352354;4448.466184057869;5687.061634830289;5698.0598201296325;5700.743466544015;5708.229389032427;5755.510781583613;6139.124180917401;6193.225846769154;6251.6874156292915;6298.905516417258;6321.178246827975;5642.85892852682;5690.601657883908;5708.543316534668;5710.514606258432;5714.9142762857755;4708.623310135181;5332.440093790174;5391.622586418992;5408.702521361363;5424.321959755031;6291.716872740738;6292.968535157295;6300.936990630218;6388.233411990591;6460.483161347081;6102.938970610237;6299.590526615755;6308.968455157695;6326.2092238470195;6331.366863313632;6215.192025036717;6277.18396608438;6283.2460104787715;6312.873742525032;6315.305316415099;6157.26112866441;6208;6210.161628180319;6210.875782484235;6216.974199257072;6108.35862234459;6135.84660383494;6214.347493513297;6297.307296197506;6306.905396418965;6032.276126864805;6068.21113255274;6093.2078829751845;6107.297660768891;6123.84690382744;6022.879542409215;6034.2155519782145;6046.516278697605;6058.939410606014;6077.027675571887;5736.6558006519745;5837.67892765902;5896.587238893237;5896.616719913192;5908.852278692895;6010.9699451502465;6085.482733967485;6091.695415229309;6099.481544068626;6111.54163437735;5862.003459411995;5919.7040147991565;5944.464998150014;5955.344912059757;5958.791442299499 05:50:22 INFO - PROCESS | 2016 | |1;ext.html;479.7529272424701;498.7581023203748;520.7500399808092;532.1963834609741;535.2747027777361;29422.999999999975;41298.79350603247;41797.95505112374;41885.58114418855;42035.369469457946;43834.342484862755;44059.55940440595;44199.116017679706;44222.7788861056;44306.7784661077;9735.464549449795;9905.702828915108;9918.065977134462;9926.25553083518;9929.354591951536;9725.27060470464;9837.65568205113;9869.506524673738;9871.60513579456;9876.061774131445;9837.262205334628;9893.30746847721;9912.603495860158;9930.503474826266;9933.255005874553;9830.410175389463;9881.80236395268;9881.851772223423;9898.158656514204;9901.75245618858;9661.758456038586;9813.90186098137;9829.852552211723;9833.704988850275;9835.213182945346;41163;41521;41583.7920810394;41608.58391416108;41738.79130604358;3626.5829429615405;3684.871029513954;4010.358342665189;4186.644135248477;4401.141777353418;31776.523352149736;32078;32495.51256731151;33314.500282495785;33335.16662083443;3248.2366643838677;3252.4633435483115;3297.1757060734817;3329.900102996914;3405.863765449379;446785.7660711708;449417;453486;454263.9999999967;456028;31903.650116737874;61490.69254653698;61915.690421548505;61934.69032654808;61954.070688939704;33191.66808331934;34599.78900738462;34731.13172170716;34772.65227347694;34888.47667284993;14859;14891.32989015497;15040.473583424528;15061.17163556015;15077.019993700374;12663.936680316723;12722.236665800081;12736.36318184087;12739.55411560591;12750.681232969064;7807.336376407955;7816.335611472975;7834.529928204326;7899.486533375312;7903.209679032051;3216.4049650814673;3240.5625240592217;3242.7081562659473;3246.3994161080277;3265.595793808685;900.8648702694517;916.4409710076848;934.2619330728648;946.597695979206;1064.2231171245035;27336;30402.391952160833;30592.54111188334;30714.385712285628;31333.06000819979;1009.7526106104051;1054.0987455725244;1081.1458947431597;1115.682030621269;1130.9151813613848;15905.840941590668;15982.961107527974;16220.432284870209;16412.1793910304;16695.74956375655;539935;674552;678286;678338;679557;62326;62784.151981002375;62860.37139628637;62901.37098628955;62964;1249.9875001250052;1296.37125993891;1357.4570171930911;1386.7850483175123;1417.2134465371612;29948.85025574858;30160.396792064475;31522.527162093047;31757.729690813034;31787.364252715277;53391.665208370105;53514.46485535095;53882.73058634682;54066.72966635141;54164.45835541594;507295;510478;538967;543869;543871;20496.59006819885;23219.83900804987;26841.194764157106;27011.91952321885;27229.591556126277;48686.02627947492;48822.267665985746;49296;49727.25409118794;49774;39234.411483828335;40226.1954760909;40719.38920916248;41051.58948410478;41413.378799318634;39998.000049998984;40301.1939761209;40309.798451007555;41089;41192.38211426771;38650.61349386583;39201.411978820914;39648;39686;39758;32254;33818.830905845316;34358.31283374268;34438.7946421874;34534;25391.61912571276;25450.618240726773;25481.10816121427;25637.487250255264;25764.871175644003 05:50:22 INFO - PROCESS | 2016 | |2;jquery.html;356.09196548800554;377.19280739218067;385.9073822282653;389.45670789249016;407.45197709081276;15334.923325383372;15764.527064188078;20033.899830500828;21122.577548449022;22232.777672223274;20699.689504657443;21212.681809772865;21272.4681882953;21910.342689719295;21914.904254787278;5598.664080155183;5810.56420768442;5853.707314634273;5863.912041319383;5864.354920958691;5695.345035320929;5799.507041901423;6024.307204671475;6054.51563874889;6092.390760923917;6060.096118153066;6071.453569178773;6090.147379366892;6093.573449858512;6100;5839.79560715375;5984.431479009487;5993.250843644544;5995.730192141364;6007.339192688801;5142.254373115878;5464.961657285103;5748.655080695172;5763.769449222026;5775.27809023872;24559.01763929441;25895.35261618456;26065.348366290804;26435.867820660773;26499.867500662374;1863.8974856382893;2190.266260802633;2319.2694301295205;2387.8657637622164;2646.742797171328;9867.851982220272;10377.066064054196;10756;11727.413629318586;15338.539843804703;1732.2724455728624;1797.7213531902576;1807.1777341309673;1818.2999545175203;1874.2034635279952;105633;110975;125952.37023814915;127135;127829.36085319606;10304.484775761182;10973.561057557768;11397.031252343479;11576.652700419001;11666.358350290815;13512.864871351358;13636;14248.715025699636;14278.714425711636;14527.055741376776;6347.39699728525;8526.74419767408;8621.956890215508;8676.60955257015;8732.476051436934;7547.16981132075;7888.566128862853;8252.711155109542;8689.608967596474;8761.430507017023;4460.933086003713;4506.278995360726;4529.932051019237;4532.501424843264;4609.700369475973;1564.4602612098809;1872.1481725814722;1910.484169274316;1911.6367890100837;1957.9804201958084;349.8006136502169;399.19761279827173;849.2356878808998;950.254050570299;966.7969726357544;11526.59656912004;12053.939730301468;12144.453499592539;12172;12185.51257949672;418.9015581338383;426.8378016353766;437.1606515490266;442.17534298533644;444.79094825431997;5986.132010858401;6061.060535616986;6152.2924863640355;6177.938220617826;6204.441600255908;630938;635551.8222408858;637072;637831.8108409521;651068;95048.52475737577;115238;125187.3740631291;138906;142923;959.3668179001826;968.9806203875883;1003.8996100390049;1007.2747621712356;1011.8229309870743;18749.156287967347;19207.32774352891;19282.22871085197;19298.938558379425;19339.226430942606;50935.745321273156;52474.737626311624;52773;52823.20765188602;53613.19580206378;81963.18036819555;82821.58589207016;83649.58175209329;84346;91054;5695.288088988877;7669.923300767144;7853.025578284062;8312.168783121639;8397.454165479225;11858.881411185777;13622;13729.107608005448;13994.440222391398;14075.648108796953;11585.246958947642;11706.414679265832;11763.117766167401;11947.462364193805;11996.76006479848;11289.491972861406;11682.824757628472;11777.411129443664;11827.290362578273;12005.879941200476;11918.940405297919;11929.46317415701;11958.64124076279;12067.698307542381;12147.574834880737;8362.121977192308;8408;8457.365697572584;8475.618597163018;8612.18184272493;5570.86072848182;8479.855219545283;9527.523623818919;11056.391898445341;11714.824277636013 05:50:22 INFO - PROCESS | 2016 | |3;mootools.html;1453.309677902996;1530.5790907500436;1714.5027941896851;1864.1890777511783;1886.9339573114944;7899;8132.878006829902;8524.104968978254;8921.197092261704;8936.463812171274;8460.450070745397;8682.869756953634;8688.435251708635;8799.780005499866;8801.471911685303;2294.4608017116007;2349.259983105316;2359.587072262347;2366.171839856045;2367.7987371073477;2097;2177.2597316912247;2314.618088015475;2335.241046659834;2355.4817940053244;2350.5181437805295;2378.3459548624182;2386.940326491843;2389.474315650554;2390.34265576966;2316.536692661466;2357.9410514737096;2364.385259832456;2370.668106465096;2371.8932648030795;2326.674265602817;2352.3883790214495;2359.1624973134635;2360.917367892133;2368.052778888441;8847;8918.910810891874;8936.553172341422;8949.418287811272;8961.283097352196;5170.715610641413;5389.51494365509;5394.595405344576;5402.486763757476;5411.296531450926;3580.6419358064245;3650.9269814603826;3699.445083237509;3716.3682174030478;3725.4411838224214;1030.0832259289239;1066.0458889294039;1086.7011571817734;1098.4946924414778;1103.3104309806372;11591.884081159165;11611.767764644745;11614.535418583331;11619.767604647945;11624.12819038567;4443.933340999887;4761.857144285677;4858.902821943541;4878;4885.8045678172475;9800;9961.80076398468;9962.701118966443;9964.352317099365;9968.651097211708;5326.813561525328;5399.379071406838;5409.24270602116;5412.377576578665;5434.076207044733;4921.7785199666105;4925.655204135748;4947.604191664658;4948.05986862495;4982.8754281143265;3622.873199438007;3784.6215378461934;3839.4450247649747;3996.4005399190355;4021.7989100544855;1158.3976332307152;1221.5663439478858;1238.912432551154;1268.2580690296095;1296.0344543315102;837.2213841127809;872.6683860133236;890.8975467821153;926.2312280806914;968.3995922528078;6015.699215039231;6085.695715214221;6086.360932102154;6127.111568822495;6135.478484328793;883.823235352932;917.1653795046476;940.5186830741609;960.9039096090474;994.9651762188289;3965.5439624443557;4078.7552746835286;4139.7580725782145;4168.333066709312;4168.541460439349;10539.156867450585;10742.194335424874;10860.185486088418;10873.891261087289;10900.34597924127;10657.946710266398;10774.676759697222;10852.457377131112;10866.511007004545;10870.619528316629;8004.5597492138495;8359.456635318686;8370.497770133812;8375.497470151811;8383.371247156487;5750.884982300414;5976.402359763989;5977.3126090500145;6032.155498230163;6106.2061931948565;9687.031296870256;9955.751106222402;10176.847347289944;10208.285420020527;10215.182785377301;8958.776030599287;10350;10367.377957322586;10378.844317335095;10388.584456621651;6351.237851457669;7092.716291348288;7123.287671233043;7225.710971561079;7247.383972362408;6931.618760968196;7564.054493188351;8323;8334.708285209988;8338.37462190326;6481.4166724994975;7155.713771449084;7262.128544574685;7455.366293865082;7737.0715514138665;7416.555006699616;7475.6635951383405;7526.548407095592;7637.732679356196;7639.579823109782;6213.844653883689;7036.226015138228;7083.716651333889;7117.181524124792;7119.466040046914;4954.058728841653;5066.771995260296;5085.288059671723;5143.3570803649545;5151.6908985461;5145.176771716508;5176.948230517647;5177.378714554277;5244;5307.548858347083 05:50:22 INFO - PROCESS | 2016 | |4;prototype.html;290.1194873558748;294.2276524124174;306.71935179310924;308.48637019362764;310.35755985110814;5421.647592906458;5500.229967804506;5500.642458240211;5533.6956467394275;5541.365297237315;5194.337991715841;5455.945440545594;5466.262054622624;5490.313710786152;5490.69801160936;3487.8256087195664;3691.667749902508;4079.9592004079877;4090.7750073745933;4113.753174809506;4011.9598804012026;4082.163156552914;4104.630583247507;4114.444549985744;4139.130782535656;3768.3028639701743;4022.658074063708;4039.9900024993754;4049.493813273341;4081.693872959525;3557.5908770491337;4011.5587285398583;4018.799060046986;4019.075612609087;4051.270771261172;3463.705585025276;3475.94786078209;3484.355394252046;3494.4234201356744;3503.1767534629344;5005.449400565972;5266.815661451869;5283.28675628789;5322.680639161663;5337.2527846101575;4581.67928245023;4616.28447590624;4624.375709279271;4655.976720116411;4658.487566367697;4776.737279449629;4999.75001249936;5665.660060396348;5679.204911312419;5683.54531637468;3541.8760343388117;3835.3288174569616;3840.3486500804643;3847.2687290719286;3870.574236833946;5570.275864137677;5709.429057094258;5756.395578464285;5950.702464876739;5956.213136059165;3737.719671024684;3872.4191371294532;3882.893375388001;3885;3894.5910679378826;3930.8231129598666;3948.940765888514;3951.1900060487533;3951.328274193394;4000.8199631016673;4301.0322677397335;4382.9780851096175;4397.538258482813;4469.5530446955045;4542.432195975503;5253.763580638881;5669.31968163823;5683.914741278884;5696.635896103154;5730.598858079978;1301.7266374061364;1318.9340532973504;1322.8941684665203;1353.9526116585873;1356.6094752878378;815.9143289954588;896.3456676626099;961.8553920834185;962.8988956159642;966.0339660339661;5070.492950704974;5265.262863199156;5320.361556613231;5331.5201631853315;5339.010154313597;5779.422057794187;5780.450857168562;5791.88416231673;5844.386339434298;5879.235699359141;4528.049109687003;4563.452385713736;4731.432228132646;4936.555709986119;5323.627346085815;2380.9285721428387;2942.514485109933;3049.2923962581026;3072.539119132103;3078.1838715157714;5569.749361278752;5997.740474500317;6011.338752737195;6019.157317975487;6064.75604026513;5283.4677943396755;5663.631863928831;5909.409059094056;5940.633634278802;5960.539667781334;4991.326170966873;5961.2846458425265;5977.282726072812;5990.430909063632;5992.531829701751;5356.295070989126;5725.6850873202375;5740.253767010262;5769.624974376652;5851.736671849691;4989.825356112518;5466.863328416822;5649.519790817826;5665.20687103814;5669.639286571276;4924.704517728947;5774.855628609318;5937.732802024006;6070.423309785563;6076.57463977535;3981.7212795104065;3991.6207960243732;3999.700172400939;4002.519697636302;4045.9190816182922;4473.507914129378;5727.198192253171;5852.5317974561085;5933.656205798599;5977.970110149421;4999.425525643995;5135.512126347991;5675.077335172472;5726.112452569859;5743.59794814359;4564.6576506762785;5700.743466543932;5747.735498190392;5767.509761670305;5801.346616214359;5303.946960530346;5396.460353964572;5568.276124103841;5613.915791263053;5638.490871562116;4971.850844474671;5655.830325090254;5730.023142015998;5731.65306153062;5757.309122905111;5165.9483405165465;5285.810692594136;5608.327000759935;5608.943910561005;5632.057559708139 05:50:22 INFO - PROCESS | 2016 | |5;yui.html;619.9132121502989;738.7192866710649;742.7994441500794;785.9882101768471;830.975070747877;14929.850701492995;16136.677266454693;16158.919205403956;16184.83815161848;16204.432844850418;14321.140731556088;14647.194404307758;14831.77752333716;14840.332185051699;14872.256387180625;864.7967727584013;866.7833041739565;866.9783255418602;867.839449701804;868.5006121480143;863.4991704811226;880.8150288439404;882.8719835623831;885.1016218538189;885.1325700813175;924.9537523123851;925.1349987761431;927.5964955244457;927.8329900617886;928.4893308680199;916.4867674102524;919.2921450483124;919.462114662923;920.0385597051097;921.3918813583003;679.2155060904663;680.7787469072522;680.8536164724608;681.5297444763098;681.6046692918145;13029.153105048237;13455.058145929788;13455.730885382238;13490.93254533731;13506.122102063433;12151.696207594792;12183.756324873542;12414.503419863195;12418.627441176688;12503.187292826027;10988.230823842334;11104.666859994133;11151.944240278828;11163.83254251187;11529.711757206136;3802.5627052888995;3822.2164456286396;3891.066144125418;3953.6441720245316;3965.524137103566;66577.66711166414;104075;104096;105448;120648;11648.94175529117;11803.763924721628;11843.763124737457;12008.939955300342;12049.759004819854;23704.64443033356;23886.044558217476;23898.88050559736;23906.760932390454;24119.75880241175;8441.366897482714;8457.746267611981;8506;8516.190961858614;8525.744227673056;4540.88647783808;4544.840930567414;4611.446626404786;4632.745199014019;4754.334393184957;3567.0369000369756;3683.1528748388023;3686.225892562592;3688.428293614494;3697.4084146536425;587.5446528940021;692.7436848366136;701.8385771272635;703.8944158376285;705.0657878311258;523.7747768459599;577.2639884147661;615.5875563372551;624.8125562331282;698.6087790837147;7682.500637458547;9536.141747242782;9571.952140239255;9652.131308182157;9746.269029822792;599.307799491588;632.253940350391;670.2827974067701;690.147667630476;715.5420530860254;4555;4576.153411618861;4688.367070445446;4693.55411235932;4696.506866778939;137602;138784;143999.5600043986;148087.51912480954;149626;83252.79469894267;108654.45672771585;111513;112915.435422824;119595.24654664651;87342;100964;101798;102922.48538757408;104486.47756761167;9747;9945;9981.950090249502;10003.099721025143;10033.749156271151;54167;58418.4158158413;59092;60587;60913.69543152256;72617.6369118151;83956;85212.57393712991;86242;86746;12899.355032248537;13043.478260869459;13237.47050118023;13343.532976345781;13702.957627499713;14418.567442976728;14699.632509187355;14753.535665073288;14948.925255374088;15139.318730657367;13597.04820662544;13620.38708258111;13771.517996870061;13821.101628394123;13870.72258554803;11817.940910295738;13514.72970540564;13946.093503922213;13981.860181398055;14014.78977815354;13346.265955372548;13347.86652133505;13605;14090;14446.566603001927;9375.812483750151;11359.148063895405;11436.085113191091;11840.76318473643;11894.940525297317;11296.378699171295;11390.487428065922;11411.315321080761;11597.76804463923;11603.013743831869 05:50:22 INFO - PROCESS | 2016 | __end_tp_report 05:50:22 INFO - PROCESS | 2016 | __start_cc_report 05:50:22 INFO - PROCESS | 2016 | _x_x_mozilla_cycle_collect,1060 05:50:22 INFO - PROCESS | 2016 | __end_cc_report 05:50:22 INFO - PROCESS | 2016 | __startTimestamp1467463822002__endTimestamp 05:50:22 INFO - PROCESS | 2016 | 05:50:22 INFO - PROCESS | 2016 | ------- Summary: start ------- 05:50:22 INFO - PROCESS | 2016 | Number of tests: 6 05:50:22 INFO - PROCESS | 2016 | 05:50:22 INFO - PROCESS | 2016 | [#0] dojo.html Cycles:165 Average:5725.48 Median:5919.70 stddev:649.89 (11.0%) stddev-sans-first:624.05 05:50:22 INFO - PROCESS | 2016 | Values: 3327.1 3352.6 3376.4 3385.2 3422.4 5606.0 5666.3 5673.3 5731.2 5766.6 5648.9 5697.0 5794.5 5808.1 5822.7 5066.4 5081.9 5152.3 5159.7 5242.4 5195.8 5228.9 5261.3 5263.6 5291.4 5082.4 5095.9 5109.1 5120.7 5155.3 5097.2 5129.6 5130.1 5229.6 5243.2 5092.7 5166.4 5167.9 5175.5 5231.8 5602.0 5707.7 5735.9 5757.9 5803.5 6056.3 6112.8 6137.7 6151.8 6212.3 6248.9 6268.2 6305.9 6312.6 6328.6 5657.3 5755.7 5769.1 5811.2 5838.4 6248.2 6298.6 6306.2 6306.8 6321.9 6137.0 6161.1 6168.9 6174.5 6175.4 6094.5 6222.8 6301.3 6325.0 6335.1 5233.2 6104.5 6133.5 6151.8 6181.5 6210.2 6218.8 6222.5 6224.3 6241.3 4862.4 4864.0 4867.3 4886.1 4918.1 4354.5 4364.3 4376.3 4399.5 4448.5 5687.1 5698.1 5700.7 5708.2 5755.5 6139.1 6193.2 6251.7 6298.9 6321.2 5642.9 5690.6 5708.5 5710.5 5714.9 4708.6 5332.4 5391.6 5408.7 5424.3 6291.7 6293.0 6300.9 6388.2 6460.5 6102.9 6299.6 6309.0 6326.2 6331.4 6215.2 6277.2 6283.2 6312.9 6315.3 6157.3 6208.0 6210.2 6210.9 6217.0 6108.4 6135.8 6214.3 6297.3 6306.9 6032.3 6068.2 6093.2 6107.3 6123.8 6022.9 6034.2 6046.5 6058.9 6077.0 5736.7 5837.7 5896.6 5896.6 5908.9 6011.0 6085.5 6091.7 6099.5 6111.5 5862.0 5919.7 5944.5 5955.3 5958.8 05:50:22 INFO - PROCESS | 2016 | 05:50:22 INFO - PROCESS | 2016 | [#1] ext.html Cycles:180 Average:67393.82 Median:41245.59 stddev:147314.10 (357.2%) stddev-sans-first:147641.68 05:50:22 INFO - PROCESS | 2016 | Values: 479.8 498.8 520.8 532.2 535.3 29423.0 41298.8 41798.0 41885.6 42035.4 43834.3 44059.6 44199.1 44222.8 44306.8 9735.5 9905.7 9918.1 9926.3 9929.4 9725.3 9837.7 9869.5 9871.6 9876.1 9837.3 9893.3 9912.6 9930.5 9933.3 9830.4 9881.8 9881.9 9898.2 9901.8 9661.8 9813.9 9829.9 9833.7 9835.2 41163.0 41521.0 41583.8 41608.6 41738.8 3626.6 3684.9 4010.4 4186.6 4401.1 31776.5 32078.0 32495.5 33314.5 33335.2 3248.2 3252.5 3297.2 3329.9 3405.9 446785.8 449417.0 453486.0 454264.0 456028.0 31903.7 61490.7 61915.7 61934.7 61954.1 33191.7 34599.8 34731.1 34772.7 34888.5 14859.0 14891.3 15040.5 15061.2 15077.0 12663.9 12722.2 12736.4 12739.6 12750.7 7807.3 7816.3 7834.5 7899.5 7903.2 3216.4 3240.6 3242.7 3246.4 3265.6 900.9 916.4 934.3 946.6 1064.2 27336.0 30402.4 30592.5 30714.4 31333.1 1009.8 1054.1 1081.1 1115.7 1130.9 15905.8 15983.0 16220.4 16412.2 16695.7 539935.0 674552.0 678286.0 678338.0 679557.0 62326.0 62784.2 62860.4 62901.4 62964.0 1250.0 1296.4 1357.5 1386.8 1417.2 29948.9 30160.4 31522.5 31757.7 31787.4 53391.7 53514.5 53882.7 54066.7 54164.5 507295.0 510478.0 538967.0 543869.0 543871.0 20496.6 23219.8 26841.2 27011.9 27229.6 48686.0 48822.3 49296.0 49727.3 49774.0 39234.4 40226.2 40719.4 41051.6 41413.4 39998.0 40301.2 40309.8 41089.0 41192.4 38650.6 39201.4 39648.0 39686.0 39758.0 32254.0 33818.8 34358.3 34438.8 34534.0 25391.6 25450.6 25481.1 25637.5 25764.9 05:50:22 INFO - PROCESS | 2016 | 05:50:22 INFO - PROCESS | 2016 | [#2] jquery.html Cycles:180 Average:35892.13 Median:381.55 stddev:106345.76 (27872.0%) stddev-sans-first:106610.61 05:50:22 INFO - PROCESS | 2016 | Values: 356.1 377.2 385.9 389.5 407.5 15334.9 15764.5 20033.9 21122.6 22232.8 20699.7 21212.7 21272.5 21910.3 21914.9 5598.7 5810.6 5853.7 5863.9 5864.4 5695.3 5799.5 6024.3 6054.5 6092.4 6060.1 6071.5 6090.1 6093.6 6100.0 5839.8 5984.4 5993.3 5995.7 6007.3 5142.3 5465.0 5748.7 5763.8 5775.3 24559.0 25895.4 26065.3 26435.9 26499.9 1863.9 2190.3 2319.3 2387.9 2646.7 9867.9 10377.1 10756.0 11727.4 15338.5 1732.3 1797.7 1807.2 1818.3 1874.2 105633.0 110975.0 125952.4 127135.0 127829.4 10304.5 10973.6 11397.0 11576.7 11666.4 13512.9 13636.0 14248.7 14278.7 14527.1 6347.4 8526.7 8622.0 8676.6 8732.5 7547.2 7888.6 8252.7 8689.6 8761.4 4460.9 4506.3 4529.9 4532.5 4609.7 1564.5 1872.1 1910.5 1911.6 1958.0 349.8 399.2 849.2 950.3 966.8 11526.6 12053.9 12144.5 12172.0 12185.5 418.9 426.8 437.2 442.2 444.8 5986.1 6061.1 6152.3 6177.9 6204.4 630938.0 635551.8 637072.0 637831.8 651068.0 95048.5 115238.0 125187.4 138906.0 142923.0 959.4 969.0 1003.9 1007.3 1011.8 18749.2 19207.3 19282.2 19298.9 19339.2 50935.7 52474.7 52773.0 52823.2 53613.2 81963.2 82821.6 83649.6 84346.0 91054.0 5695.3 7669.9 7853.0 8312.2 8397.5 11858.9 13622.0 13729.1 13994.4 14075.6 11585.2 11706.4 11763.1 11947.5 11996.8 11289.5 11682.8 11777.4 11827.3 12005.9 11918.9 11929.5 11958.6 12067.7 12147.6 8362.1 8408.0 8457.4 8475.6 8612.2 5570.9 8479.9 9527.5 11056.4 11714.8 05:50:22 INFO - PROCESS | 2016 | 05:50:22 INFO - PROCESS | 2016 | [#3] mootools.html Cycles:180 Average:5728.16 Median:5144.27 stddev:3188.88 (62.0%) stddev-sans-first:3181.64 05:50:22 INFO - PROCESS | 2016 | Values: 1453.3 1530.6 1714.5 1864.2 1886.9 7899.0 8132.9 8524.1 8921.2 8936.5 8460.5 8682.9 8688.4 8799.8 8801.5 2294.5 2349.3 2359.6 2366.2 2367.8 2097.0 2177.3 2314.6 2335.2 2355.5 2350.5 2378.3 2386.9 2389.5 2390.3 2316.5 2357.9 2364.4 2370.7 2371.9 2326.7 2352.4 2359.2 2360.9 2368.1 8847.0 8918.9 8936.6 8949.4 8961.3 5170.7 5389.5 5394.6 5402.5 5411.3 3580.6 3650.9 3699.4 3716.4 3725.4 1030.1 1066.0 1086.7 1098.5 1103.3 11591.9 11611.8 11614.5 11619.8 11624.1 4443.9 4761.9 4858.9 4878.0 4885.8 9800.0 9961.8 9962.7 9964.4 9968.7 5326.8 5399.4 5409.2 5412.4 5434.1 4921.8 4925.7 4947.6 4948.1 4982.9 3622.9 3784.6 3839.4 3996.4 4021.8 1158.4 1221.6 1238.9 1268.3 1296.0 837.2 872.7 890.9 926.2 968.4 6015.7 6085.7 6086.4 6127.1 6135.5 883.8 917.2 940.5 960.9 995.0 3965.5 4078.8 4139.8 4168.3 4168.5 10539.2 10742.2 10860.2 10873.9 10900.3 10657.9 10774.7 10852.5 10866.5 10870.6 8004.6 8359.5 8370.5 8375.5 8383.4 5750.9 5976.4 5977.3 6032.2 6106.2 9687.0 9955.8 10176.8 10208.3 10215.2 8958.8 10350.0 10367.4 10378.8 10388.6 6351.2 7092.7 7123.3 7225.7 7247.4 6931.6 7564.1 8323.0 8334.7 8338.4 6481.4 7155.7 7262.1 7455.4 7737.1 7416.6 7475.7 7526.5 7637.7 7639.6 6213.8 7036.2 7083.7 7117.2 7119.5 4954.1 5066.8 5085.3 5143.4 5151.7 5145.2 5176.9 5177.4 5244.0 5307.5 05:50:22 INFO - PROCESS | 2016 | 05:50:22 INFO - PROCESS | 2016 | [#4] prototype.html Cycles:180 Average:4605.93 Median:5275.05 stddev:1418.47 (26.9%) stddev-sans-first:1384.97 05:50:22 INFO - PROCESS | 2016 | Values: 290.1 294.2 306.7 308.5 310.4 5421.6 5500.2 5500.6 5533.7 5541.4 5194.3 5455.9 5466.3 5490.3 5490.7 3487.8 3691.7 4080.0 4090.8 4113.8 4012.0 4082.2 4104.6 4114.4 4139.1 3768.3 4022.7 4040.0 4049.5 4081.7 3557.6 4011.6 4018.8 4019.1 4051.3 3463.7 3475.9 3484.4 3494.4 3503.2 5005.4 5266.8 5283.3 5322.7 5337.3 4581.7 4616.3 4624.4 4656.0 4658.5 4776.7 4999.8 5665.7 5679.2 5683.5 3541.9 3835.3 3840.3 3847.3 3870.6 5570.3 5709.4 5756.4 5950.7 5956.2 3737.7 3872.4 3882.9 3885.0 3894.6 3930.8 3948.9 3951.2 3951.3 4000.8 4301.0 4383.0 4397.5 4469.6 4542.4 5253.8 5669.3 5683.9 5696.6 5730.6 1301.7 1318.9 1322.9 1354.0 1356.6 815.9 896.3 961.9 962.9 966.0 5070.5 5265.3 5320.4 5331.5 5339.0 5779.4 5780.5 5791.9 5844.4 5879.2 4528.0 4563.5 4731.4 4936.6 5323.6 2380.9 2942.5 3049.3 3072.5 3078.2 5569.7 5997.7 6011.3 6019.2 6064.8 5283.5 5663.6 5909.4 5940.6 5960.5 4991.3 5961.3 5977.3 5990.4 5992.5 5356.3 5725.7 5740.3 5769.6 5851.7 4989.8 5466.9 5649.5 5665.2 5669.6 4924.7 5774.9 5937.7 6070.4 6076.6 3981.7 3991.6 3999.7 4002.5 4045.9 4473.5 5727.2 5852.5 5933.7 5978.0 4999.4 5135.5 5675.1 5726.1 5743.6 4564.7 5700.7 5747.7 5767.5 5801.3 5303.9 5396.5 5568.3 5613.9 5638.5 4971.9 5655.8 5730.0 5731.7 5757.3 5165.9 5285.8 5608.3 5608.9 5632.1 05:50:22 INFO - PROCESS | 2016 | 05:50:22 INFO - PROCESS | 2016 | [#5] yui.html Cycles:180 Average:23290.51 Median:3687.33 stddev:36078.16 (978.4%) stddev-sans-first:36139.21 05:50:22 INFO - PROCESS | 2016 | Values: 619.9 738.7 742.8 786.0 831.0 14929.9 16136.7 16158.9 16184.8 16204.4 14321.1 14647.2 14831.8 14840.3 14872.3 864.8 866.8 867.0 867.8 868.5 863.5 880.8 882.9 885.1 885.1 925.0 925.1 927.6 927.8 928.5 916.5 919.3 919.5 920.0 921.4 679.2 680.8 680.9 681.5 681.6 13029.2 13455.1 13455.7 13490.9 13506.1 12151.7 12183.8 12414.5 12418.6 12503.2 10988.2 11104.7 11151.9 11163.8 11529.7 3802.6 3822.2 3891.1 3953.6 3965.5 66577.7 104075.0 104096.0 105448.0 120648.0 11648.9 11803.8 11843.8 12008.9 12049.8 23704.6 23886.0 23898.9 23906.8 24119.8 8441.4 8457.7 8506.0 8516.2 8525.7 4540.9 4544.8 4611.4 4632.7 4754.3 3567.0 3683.2 3686.2 3688.4 3697.4 587.5 692.7 701.8 703.9 705.1 523.8 577.3 615.6 624.8 698.6 7682.5 9536.1 9572.0 9652.1 9746.3 599.3 632.3 670.3 690.1 715.5 4555.0 4576.2 4688.4 4693.6 4696.5 137602.0 138784.0 143999.6 148087.5 149626.0 83252.8 108654.5 111513.0 112915.4 119595.2 87342.0 100964.0 101798.0 102922.5 104486.5 9747.0 9945.0 9982.0 10003.1 10033.7 54167.0 58418.4 59092.0 60587.0 60913.7 72617.6 83956.0 85212.6 86242.0 86746.0 12899.4 13043.5 13237.5 13343.5 13703.0 14418.6 14699.6 14753.5 14948.9 15139.3 13597.0 13620.4 13771.5 13821.1 13870.7 11817.9 13514.7 13946.1 13981.9 14014.8 13346.3 13347.9 13605.0 14090.0 14446.6 9375.8 11359.1 11436.1 11840.8 11894.9 11296.4 11390.5 11411.3 11597.8 11603.0 05:50:22 INFO - PROCESS | 2016 | -------- Summary: end -------- 05:50:22 INFO - PROCESS | 2016 | 05:50:22 INFO - TEST-INFO | 2016: exit 0 05:50:22 INFO - TEST-OK | dromaeo_css | took 1115776ms 05:50:22 INFO - TEST-START | kraken 05:50:22 INFO - operating with platform_type : mac_ 05:50:22 INFO - Initialising browser for kraken test... 05:50:22 INFO - TEST-INFO | started process 2020 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmp59dVBi/profile http://localhost:49376/getInfo.html) 05:50:24 INFO - PROCESS | 2020 | __metrics Screen width/height:1600/1200 05:50:24 INFO - PROCESS | 2020 | colorDepth:24 05:50:24 INFO - PROCESS | 2020 | Browser inner width/height: 1024/689 05:50:24 INFO - PROCESS | 2020 | __metrics 05:50:25 INFO - PROCESS | 2020 | 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" 05:50:25 INFO - PROCESS | 2020 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:50:25 INFO - TEST-INFO | 2020: exit 0 05:50:25 INFO - Browser initialized. 05:50:25 INFO - Running cycle 1/1 for kraken test... 05:50:25 INFO - TEST-INFO | started process 2022 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmp59dVBi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:37 INFO - PROCESS | 2022 | RSS: Main: 244957184 05:50:37 INFO - PROCESS | 2022 | 05:50:40 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-beat-detection) 05:50:41 INFO - PROCESS | 2022 | RSS: Main: 293990400 05:50:41 INFO - PROCESS | 2022 | 05:50:44 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-dft) 05:50:44 INFO - PROCESS | 2022 | RSS: Main: 304627712 05:50:44 INFO - PROCESS | 2022 | 05:50:48 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-fft) 05:50:49 INFO - PROCESS | 2022 | RSS: Main: 392208384 05:50:49 INFO - PROCESS | 2022 | 05:50:51 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-oscillator) 05:50:51 INFO - PROCESS | 2022 | RSS: Main: 293552128 05:50:51 INFO - PROCESS | 2022 | 05:50:54 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:50:54 INFO - PROCESS | 2022 | RSS: Main: 297668608 05:50:54 INFO - PROCESS | 2022 | 05:50:57 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:58 INFO - PROCESS | 2022 | RSS: Main: 334278656 05:50:58 INFO - PROCESS | 2022 | 05:51:01 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-desaturate) 05:51:01 INFO - PROCESS | 2022 | RSS: Main: 337104896 05:51:01 INFO - PROCESS | 2022 | 05:51:04 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49376/tests/kraken/driver.html?testName=json-parse-financial) 05:51:05 INFO - PROCESS | 2022 | RSS: Main: 333811712 05:51:05 INFO - PROCESS | 2022 | 05:51:06 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:51:07 INFO - PROCESS | 2022 | RSS: Main: 311717888 05:51:07 INFO - PROCESS | 2022 | 05:51:09 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:51:09 INFO - PROCESS | 2022 | RSS: Main: 318058496 05:51:09 INFO - PROCESS | 2022 | 05:51:12 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:51:12 INFO - PROCESS | 2022 | RSS: Main: 316014592 05:51:12 INFO - PROCESS | 2022 | 05:51:15 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:51:16 INFO - PROCESS | 2022 | RSS: Main: 325214208 05:51:16 INFO - PROCESS | 2022 | 05:51:19 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:51:19 INFO - PROCESS | 2022 | RSS: Main: 327639040 05:51:19 INFO - PROCESS | 2022 | 05:51:21 INFO - PROCESS | 2022 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49376/tests/kraken/driver.html?testName=ai-astar) 05:51:22 INFO - PROCESS | 2022 | RSS: Main: 371023872 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | __start_tp_report 05:51:22 INFO - PROCESS | 2022 | _x_x_mozilla_page_load 05:51:22 INFO - PROCESS | 2022 | _x_x_mozilla_page_load_details 05:51:22 INFO - PROCESS | 2022 | |i|pagename|runs| 05:51:22 INFO - PROCESS | 2022 | |0;ai-astar;102;112;114;114;160;155;113;112;112;114 05:51:22 INFO - PROCESS | 2022 | |1;audio-beat-detection;143;110;106;161;130;132;131;109;163;105 05:51:22 INFO - PROCESS | 2022 | |2;audio-dft;185;184;205;258;182;184;202;243;183;184 05:51:22 INFO - PROCESS | 2022 | |3;audio-fft;79;76;58;88;60;58;61;66;84;57 05:51:22 INFO - PROCESS | 2022 | |4;audio-oscillator;89;88;93;71;73;67;114;96;93;117 05:51:22 INFO - PROCESS | 2022 | |5;imaging-gaussian-blur;88;87;90;88;94;88;91;88;93;86 05:51:22 INFO - PROCESS | 2022 | |6;imaging-darkroom;96;96;95;104;141;120;96;96;96;95 05:51:22 INFO - PROCESS | 2022 | |7;imaging-desaturate;85;84;85;84;84;84;84;83;84;85 05:51:22 INFO - PROCESS | 2022 | |8;json-parse-financial;55;53;54;54;55;55;55;55;55;55 05:51:22 INFO - PROCESS | 2022 | |9;json-stringify-tinderbox;70;72;69;77;74;73;70;69;70;70 05:51:22 INFO - PROCESS | 2022 | |10;stanford-crypto-aes;83;85;82;85;82;87;90;97;70;85 05:51:22 INFO - PROCESS | 2022 | |11;stanford-crypto-ccm;136;139;138;138;153;153;147;135;226;163 05:51:22 INFO - PROCESS | 2022 | |12;stanford-crypto-pbkdf2;162;160;164;161;163;161;163;163;160;166 05:51:22 INFO - PROCESS | 2022 | |13;stanford-crypto-sha256-iterative;68;67;67;68;67;67;63;66;81;80 05:51:22 INFO - PROCESS | 2022 | __end_tp_report 05:51:22 INFO - PROCESS | 2022 | __start_cc_report 05:51:22 INFO - PROCESS | 2022 | _x_x_mozilla_cycle_collect,2114 05:51:22 INFO - PROCESS | 2022 | __end_cc_report 05:51:22 INFO - PROCESS | 2022 | __startTimestamp1467463882038__endTimestamp 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | ------- Summary: start ------- 05:51:22 INFO - PROCESS | 2022 | Number of tests: 14 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | [#0] ai-astar Cycles:10 Average:120.80 Median:114.00 stddev:19.70 (17.3%) stddev-sans-first:19.68 05:51:22 INFO - PROCESS | 2022 | Values: 102.0 112.0 114.0 114.0 160.0 155.0 113.0 112.0 112.0 114.0 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:131.50 stddev:21.75 (16.5%) stddev-sans-first:22.47 05:51:22 INFO - PROCESS | 2022 | Values: 143.0 110.0 106.0 161.0 130.0 132.0 131.0 109.0 163.0 105.0 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | [#2] audio-dft Cycles:10 Average:201.00 Median:193.50 stddev:27.56 (14.2%) stddev-sans-first:28.62 05:51:22 INFO - PROCESS | 2022 | Values: 185.0 184.0 205.0 258.0 182.0 184.0 202.0 243.0 183.0 184.0 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | [#3] audio-fft Cycles:10 Average:68.70 Median:71.00 stddev:11.90 (16.8%) stddev-sans-first:12.02 05:51:22 INFO - PROCESS | 2022 | Values: 79.0 76.0 58.0 88.0 60.0 58.0 61.0 66.0 84.0 57.0 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:88.50 stddev:16.81 (19.0%) stddev-sans-first:17.82 05:51:22 INFO - PROCESS | 2022 | Values: 89.0 88.0 93.0 71.0 73.0 67.0 114.0 96.0 93.0 117.0 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:89.00 stddev:2.63 (3.0%) stddev-sans-first:2.74 05:51:22 INFO - PROCESS | 2022 | Values: 88.0 87.0 90.0 88.0 94.0 88.0 91.0 88.0 93.0 86.0 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | [#6] imaging-darkroom Cycles:10 Average:103.50 Median:96.00 stddev:15.29 (15.9%) stddev-sans-first:15.98 05:51:22 INFO - PROCESS | 2022 | Values: 96.0 96.0 95.0 104.0 141.0 120.0 96.0 96.0 96.0 95.0 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.63 (0.8%) stddev-sans-first:0.60 05:51:22 INFO - PROCESS | 2022 | Values: 85.0 84.0 85.0 84.0 84.0 84.0 84.0 83.0 84.0 85.0 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 05:51:22 INFO - PROCESS | 2022 | Values: 55.0 53.0 54.0 54.0 55.0 55.0 55.0 55.0 55.0 55.0 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.00 stddev:2.59 (3.6%) stddev-sans-first:2.70 05:51:22 INFO - PROCESS | 2022 | Values: 70.0 72.0 69.0 77.0 74.0 73.0 70.0 69.0 70.0 70.0 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:6.82 (8.0%) stddev-sans-first:7.21 05:51:22 INFO - PROCESS | 2022 | Values: 83.0 85.0 82.0 85.0 82.0 87.0 90.0 97.0 70.0 85.0 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | [#11] stanford-crypto-ccm Cycles:10 Average:152.80 Median:150.00 stddev:27.33 (18.2%) stddev-sans-first:28.31 05:51:22 INFO - PROCESS | 2022 | Values: 136.0 139.0 138.0 138.0 153.0 153.0 147.0 135.0 226.0 163.0 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:163.00 stddev:1.89 (1.2%) stddev-sans-first:2.00 05:51:22 INFO - PROCESS | 2022 | Values: 162.0 160.0 164.0 161.0 163.0 161.0 163.0 163.0 160.0 166.0 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - PROCESS | 2022 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:67.50 stddev:6.02 (8.9%) stddev-sans-first:6.37 05:51:22 INFO - PROCESS | 2022 | Values: 68.0 67.0 67.0 68.0 67.0 67.0 63.0 66.0 81.0 80.0 05:51:22 INFO - PROCESS | 2022 | -------- Summary: end -------- 05:51:22 INFO - PROCESS | 2022 | 05:51:22 INFO - TEST-INFO | 2022: exit 0 05:51:22 INFO - TEST-OK | kraken | took 60276ms 05:51:22 INFO - SUITE-END | took 1176s 05:51:23 INFO - Completed test suite (00:19:36) 05:51:23 INFO - javascript benchmark 05:51:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3327.1016825457127, 3352.631210566837, 3376.358491886541, 3385.2213990782134, 3422.4181889078855, 5606.046972014768, 5666.348369937453, 5673.26247587813, 5731.226284451598, 5766.625169363993, 5648.887022259552, 5697.03150464422, 5794.478496935286, 5808.099744539592, 5822.737976791044, 5066.41736200338, 5081.898362032757, 5152.304438900738, 5159.690418574879, 5242.423333433319, 5195.792168313263, 5228.895422091556, 5261.342332208474, 5263.631545791796, 5291.417944026154, 5082.415522214956, 5095.949040509585, 5109.054824857413, 5120.692758434506, 5155.304033955405, 5097.184450487941, 5129.615278854101, 5130.102232109366, 5229.581633469314, 5243.161094224905, 5092.7453627318855, 5166.405863325728, 5167.9224811627855, 5175.45657705943, 5231.843044708665, 5601.971990140064, 5707.6575405475805, 5735.856603584902, 5757.884842303172, 5803.5357171426185, 6056.2729940271365, 6112.807455516543, 6137.7447333336595, 6151.846203844895, 6212.285587157489, 6248.9062664060075, 6268.216472940882, 6305.873882522324, 6312.621242725405, 6328.588641738273, 5657.349404818417, 5755.6834374108985, 5769.076947688392, 5811.186433899257, 5838.357780644125, 6248.156498872594, 6298.622082675054, 6306.24325080984, 6306.8423289417215, 6321.8735625288155, 6136.969315153396, 6161.137440758297, 6168.907466388007, 6174.475169610543, 6175.3824617538785, 6094.471245618374, 6222.81331560054, 6301.306856245809, 6325.0, 6335.11308416822, 5233.215017747369, 6104.511639068864, 6133.548895741652, 6151.815445536641, 6181.536384771161, 6210.161628180228, 6218.844528886814, 6222.533310001678, 6224.346443623354, 6241.282252541016, 4862.367892173995, 4863.9785645014235, 4867.34290870735, 4886.120498310338, 4918.065567542156, 4354.521002689701, 4364.279893817548, 4376.256036473807, 4399.472063352354, 4448.466184057869, 5687.061634830289, 5698.0598201296325, 5700.743466544015, 5708.229389032427, 5755.510781583613, 6139.124180917401, 6193.225846769154, 6251.6874156292915, 6298.905516417258, 6321.178246827975, 5642.85892852682, 5690.601657883908, 5708.543316534668, 5710.514606258432, 5714.9142762857755, 4708.623310135181, 5332.440093790174, 5391.622586418992, 5408.702521361363, 5424.321959755031, 6291.716872740738, 6292.968535157295, 6300.936990630218, 6388.233411990591, 6460.483161347081, 6102.938970610237, 6299.590526615755, 6308.968455157695, 6326.2092238470195, 6331.366863313632, 6215.192025036717, 6277.18396608438, 6283.2460104787715, 6312.873742525032, 6315.305316415099, 6157.26112866441, 6208.0, 6210.161628180319, 6210.875782484235, 6216.974199257072, 6108.35862234459, 6135.84660383494, 6214.347493513297, 6297.307296197506, 6306.905396418965, 6032.276126864805, 6068.21113255274, 6093.2078829751845, 6107.297660768891, 6123.84690382744, 6022.879542409215, 6034.2155519782145, 6046.516278697605, 6058.939410606014, 6077.027675571887, 5736.6558006519745, 5837.67892765902, 5896.587238893237, 5896.616719913192, 5908.852278692895, 6010.9699451502465, 6085.482733967485, 6091.695415229309, 6099.481544068626, 6111.54163437735, 5862.003459411995, 5919.7040147991565, 5944.464998150014, 5955.344912059757, 5958.791442299499], "value": 5682.972464123253, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.7529272424701, 498.7581023203748, 520.7500399808092, 532.1963834609741, 535.2747027777361, 29422.999999999975, 41298.79350603247, 41797.95505112374, 41885.58114418855, 42035.369469457946, 43834.342484862755, 44059.55940440595, 44199.116017679706, 44222.7788861056, 44306.7784661077, 9735.464549449795, 9905.702828915108, 9918.065977134462, 9926.25553083518, 9929.354591951536, 9725.27060470464, 9837.65568205113, 9869.506524673738, 9871.60513579456, 9876.061774131445, 9837.262205334628, 9893.30746847721, 9912.603495860158, 9930.503474826266, 9933.255005874553, 9830.410175389463, 9881.80236395268, 9881.851772223423, 9898.158656514204, 9901.75245618858, 9661.758456038586, 9813.90186098137, 9829.852552211723, 9833.704988850275, 9835.213182945346, 41163.0, 41521.0, 41583.7920810394, 41608.58391416108, 41738.79130604358, 3626.5829429615405, 3684.871029513954, 4010.358342665189, 4186.644135248477, 4401.141777353418, 31776.523352149736, 32078.0, 32495.51256731151, 33314.500282495785, 33335.16662083443, 3248.2366643838677, 3252.4633435483115, 3297.1757060734817, 3329.900102996914, 3405.863765449379, 446785.7660711708, 449417.0, 453486.0, 454263.9999999967, 456028.0, 31903.650116737874, 61490.69254653698, 61915.690421548505, 61934.69032654808, 61954.070688939704, 33191.66808331934, 34599.78900738462, 34731.13172170716, 34772.65227347694, 34888.47667284993, 14859.0, 14891.32989015497, 15040.473583424528, 15061.17163556015, 15077.019993700374, 12663.936680316723, 12722.236665800081, 12736.36318184087, 12739.55411560591, 12750.681232969064, 7807.336376407955, 7816.335611472975, 7834.529928204326, 7899.486533375312, 7903.209679032051, 3216.4049650814673, 3240.5625240592217, 3242.7081562659473, 3246.3994161080277, 3265.595793808685, 900.8648702694517, 916.4409710076848, 934.2619330728648, 946.597695979206, 1064.2231171245035, 27336.0, 30402.391952160833, 30592.54111188334, 30714.385712285628, 31333.06000819979, 1009.7526106104051, 1054.0987455725244, 1081.1458947431597, 1115.682030621269, 1130.9151813613848, 15905.840941590668, 15982.961107527974, 16220.432284870209, 16412.1793910304, 16695.74956375655, 539935.0, 674552.0, 678286.0, 678338.0, 679557.0, 62326.0, 62784.151981002375, 62860.37139628637, 62901.37098628955, 62964.0, 1249.9875001250052, 1296.37125993891, 1357.4570171930911, 1386.7850483175123, 1417.2134465371612, 29948.85025574858, 30160.396792064475, 31522.527162093047, 31757.729690813034, 31787.364252715277, 53391.665208370105, 53514.46485535095, 53882.73058634682, 54066.72966635141, 54164.45835541594, 507295.0, 510478.0, 538967.0, 543869.0, 543871.0, 20496.59006819885, 23219.83900804987, 26841.194764157106, 27011.91952321885, 27229.591556126277, 48686.02627947492, 48822.267665985746, 49296.0, 49727.25409118794, 49774.0, 39234.411483828335, 40226.1954760909, 40719.38920916248, 41051.58948410478, 41413.378799318634, 39998.000049998984, 40301.1939761209, 40309.798451007555, 41089.0, 41192.38211426771, 38650.61349386583, 39201.411978820914, 39648.0, 39686.0, 39758.0, 32254.0, 33818.830905845316, 34358.31283374268, 34438.7946421874, 34534.0, 25391.61912571276, 25450.618240726773, 25481.10816121427, 25637.487250255264, 25764.871175644003], "value": 18981.769606556045, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.09196548800554, 377.19280739218067, 385.9073822282653, 389.45670789249016, 407.45197709081276, 15334.923325383372, 15764.527064188078, 20033.899830500828, 21122.577548449022, 22232.777672223274, 20699.689504657443, 21212.681809772865, 21272.4681882953, 21910.342689719295, 21914.904254787278, 5598.664080155183, 5810.56420768442, 5853.707314634273, 5863.912041319383, 5864.354920958691, 5695.345035320929, 5799.507041901423, 6024.307204671475, 6054.51563874889, 6092.390760923917, 6060.096118153066, 6071.453569178773, 6090.147379366892, 6093.573449858512, 6100.0, 5839.79560715375, 5984.431479009487, 5993.250843644544, 5995.730192141364, 6007.339192688801, 5142.254373115878, 5464.961657285103, 5748.655080695172, 5763.769449222026, 5775.27809023872, 24559.01763929441, 25895.35261618456, 26065.348366290804, 26435.867820660773, 26499.867500662374, 1863.8974856382893, 2190.266260802633, 2319.2694301295205, 2387.8657637622164, 2646.742797171328, 9867.851982220272, 10377.066064054196, 10756.0, 11727.413629318586, 15338.539843804703, 1732.2724455728624, 1797.7213531902576, 1807.1777341309673, 1818.2999545175203, 1874.2034635279952, 105633.0, 110975.0, 125952.37023814915, 127135.0, 127829.36085319606, 10304.484775761182, 10973.561057557768, 11397.031252343479, 11576.652700419001, 11666.358350290815, 13512.864871351358, 13636.0, 14248.715025699636, 14278.714425711636, 14527.055741376776, 6347.39699728525, 8526.74419767408, 8621.956890215508, 8676.60955257015, 8732.476051436934, 7547.16981132075, 7888.566128862853, 8252.711155109542, 8689.608967596474, 8761.430507017023, 4460.933086003713, 4506.278995360726, 4529.932051019237, 4532.501424843264, 4609.700369475973, 1564.4602612098809, 1872.1481725814722, 1910.484169274316, 1911.6367890100837, 1957.9804201958084, 349.8006136502169, 399.19761279827173, 849.2356878808998, 950.254050570299, 966.7969726357544, 11526.59656912004, 12053.939730301468, 12144.453499592539, 12172.0, 12185.51257949672, 418.9015581338383, 426.8378016353766, 437.1606515490266, 442.17534298533644, 444.79094825431997, 5986.132010858401, 6061.060535616986, 6152.2924863640355, 6177.938220617826, 6204.441600255908, 630938.0, 635551.8222408858, 637072.0, 637831.8108409521, 651068.0, 95048.52475737577, 115238.0, 125187.3740631291, 138906.0, 142923.0, 959.3668179001826, 968.9806203875883, 1003.8996100390049, 1007.2747621712356, 1011.8229309870743, 18749.156287967347, 19207.32774352891, 19282.22871085197, 19298.938558379425, 19339.226430942606, 50935.745321273156, 52474.737626311624, 52773.0, 52823.20765188602, 53613.19580206378, 81963.18036819555, 82821.58589207016, 83649.58175209329, 84346.0, 91054.0, 5695.288088988877, 7669.923300767144, 7853.025578284062, 8312.168783121639, 8397.454165479225, 11858.881411185777, 13622.0, 13729.107608005448, 13994.440222391398, 14075.648108796953, 11585.246958947642, 11706.414679265832, 11763.117766167401, 11947.462364193805, 11996.76006479848, 11289.491972861406, 11682.824757628472, 11777.411129443664, 11827.290362578273, 12005.879941200476, 11918.940405297919, 11929.46317415701, 11958.64124076279, 12067.698307542381, 12147.574834880737, 8362.121977192308, 8408.0, 8457.365697572584, 8475.618597163018, 8612.18184272493, 5570.86072848182, 8479.855219545283, 9527.523623818919, 11056.391898445341, 11714.824277636013], "value": 9056.431952345985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.309677902996, 1530.5790907500436, 1714.5027941896851, 1864.1890777511783, 1886.9339573114944, 7899.0, 8132.878006829902, 8524.104968978254, 8921.197092261704, 8936.463812171274, 8460.450070745397, 8682.869756953634, 8688.435251708635, 8799.780005499866, 8801.471911685303, 2294.4608017116007, 2349.259983105316, 2359.587072262347, 2366.171839856045, 2367.7987371073477, 2097.0, 2177.2597316912247, 2314.618088015475, 2335.241046659834, 2355.4817940053244, 2350.5181437805295, 2378.3459548624182, 2386.940326491843, 2389.474315650554, 2390.34265576966, 2316.536692661466, 2357.9410514737096, 2364.385259832456, 2370.668106465096, 2371.8932648030795, 2326.674265602817, 2352.3883790214495, 2359.1624973134635, 2360.917367892133, 2368.052778888441, 8847.0, 8918.910810891874, 8936.553172341422, 8949.418287811272, 8961.283097352196, 5170.715610641413, 5389.51494365509, 5394.595405344576, 5402.486763757476, 5411.296531450926, 3580.6419358064245, 3650.9269814603826, 3699.445083237509, 3716.3682174030478, 3725.4411838224214, 1030.0832259289239, 1066.0458889294039, 1086.7011571817734, 1098.4946924414778, 1103.3104309806372, 11591.884081159165, 11611.767764644745, 11614.535418583331, 11619.767604647945, 11624.12819038567, 4443.933340999887, 4761.857144285677, 4858.902821943541, 4878.0, 4885.8045678172475, 9800.0, 9961.80076398468, 9962.701118966443, 9964.352317099365, 9968.651097211708, 5326.813561525328, 5399.379071406838, 5409.24270602116, 5412.377576578665, 5434.076207044733, 4921.7785199666105, 4925.655204135748, 4947.604191664658, 4948.05986862495, 4982.8754281143265, 3622.873199438007, 3784.6215378461934, 3839.4450247649747, 3996.4005399190355, 4021.7989100544855, 1158.3976332307152, 1221.5663439478858, 1238.912432551154, 1268.2580690296095, 1296.0344543315102, 837.2213841127809, 872.6683860133236, 890.8975467821153, 926.2312280806914, 968.3995922528078, 6015.699215039231, 6085.695715214221, 6086.360932102154, 6127.111568822495, 6135.478484328793, 883.823235352932, 917.1653795046476, 940.5186830741609, 960.9039096090474, 994.9651762188289, 3965.5439624443557, 4078.7552746835286, 4139.7580725782145, 4168.333066709312, 4168.541460439349, 10539.156867450585, 10742.194335424874, 10860.185486088418, 10873.891261087289, 10900.34597924127, 10657.946710266398, 10774.676759697222, 10852.457377131112, 10866.511007004545, 10870.619528316629, 8004.5597492138495, 8359.456635318686, 8370.497770133812, 8375.497470151811, 8383.371247156487, 5750.884982300414, 5976.402359763989, 5977.3126090500145, 6032.155498230163, 6106.2061931948565, 9687.031296870256, 9955.751106222402, 10176.847347289944, 10208.285420020527, 10215.182785377301, 8958.776030599287, 10350.0, 10367.377957322586, 10378.844317335095, 10388.584456621651, 6351.237851457669, 7092.716291348288, 7123.287671233043, 7225.710971561079, 7247.383972362408, 6931.618760968196, 7564.054493188351, 8323.0, 8334.708285209988, 8338.37462190326, 6481.4166724994975, 7155.713771449084, 7262.128544574685, 7455.366293865082, 7737.0715514138665, 7416.555006699616, 7475.6635951383405, 7526.548407095592, 7637.732679356196, 7639.579823109782, 6213.844653883689, 7036.226015138228, 7083.716651333889, 7117.181524124792, 7119.466040046914, 4954.058728841653, 5066.771995260296, 5085.288059671723, 5143.3570803649545, 5151.6908985461, 5145.176771716508, 5176.948230517647, 5177.378714554277, 5244.0, 5307.548858347083], "value": 4610.450136153506, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.1194873558748, 294.2276524124174, 306.71935179310924, 308.48637019362764, 310.35755985110814, 5421.647592906458, 5500.229967804506, 5500.642458240211, 5533.6956467394275, 5541.365297237315, 5194.337991715841, 5455.945440545594, 5466.262054622624, 5490.313710786152, 5490.69801160936, 3487.8256087195664, 3691.667749902508, 4079.9592004079877, 4090.7750073745933, 4113.753174809506, 4011.9598804012026, 4082.163156552914, 4104.630583247507, 4114.444549985744, 4139.130782535656, 3768.3028639701743, 4022.658074063708, 4039.9900024993754, 4049.493813273341, 4081.693872959525, 3557.5908770491337, 4011.5587285398583, 4018.799060046986, 4019.075612609087, 4051.270771261172, 3463.705585025276, 3475.94786078209, 3484.355394252046, 3494.4234201356744, 3503.1767534629344, 5005.449400565972, 5266.815661451869, 5283.28675628789, 5322.680639161663, 5337.2527846101575, 4581.67928245023, 4616.28447590624, 4624.375709279271, 4655.976720116411, 4658.487566367697, 4776.737279449629, 4999.75001249936, 5665.660060396348, 5679.204911312419, 5683.54531637468, 3541.8760343388117, 3835.3288174569616, 3840.3486500804643, 3847.2687290719286, 3870.574236833946, 5570.275864137677, 5709.429057094258, 5756.395578464285, 5950.702464876739, 5956.213136059165, 3737.719671024684, 3872.4191371294532, 3882.893375388001, 3885.0, 3894.5910679378826, 3930.8231129598666, 3948.940765888514, 3951.1900060487533, 3951.328274193394, 4000.8199631016673, 4301.0322677397335, 4382.9780851096175, 4397.538258482813, 4469.5530446955045, 4542.432195975503, 5253.763580638881, 5669.31968163823, 5683.914741278884, 5696.635896103154, 5730.598858079978, 1301.7266374061364, 1318.9340532973504, 1322.8941684665203, 1353.9526116585873, 1356.6094752878378, 815.9143289954588, 896.3456676626099, 961.8553920834185, 962.8988956159642, 966.0339660339661, 5070.492950704974, 5265.262863199156, 5320.361556613231, 5331.5201631853315, 5339.010154313597, 5779.422057794187, 5780.450857168562, 5791.88416231673, 5844.386339434298, 5879.235699359141, 4528.049109687003, 4563.452385713736, 4731.432228132646, 4936.555709986119, 5323.627346085815, 2380.9285721428387, 2942.514485109933, 3049.2923962581026, 3072.539119132103, 3078.1838715157714, 5569.749361278752, 5997.740474500317, 6011.338752737195, 6019.157317975487, 6064.75604026513, 5283.4677943396755, 5663.631863928831, 5909.409059094056, 5940.633634278802, 5960.539667781334, 4991.326170966873, 5961.2846458425265, 5977.282726072812, 5990.430909063632, 5992.531829701751, 5356.295070989126, 5725.6850873202375, 5740.253767010262, 5769.624974376652, 5851.736671849691, 4989.825356112518, 5466.863328416822, 5649.519790817826, 5665.20687103814, 5669.639286571276, 4924.704517728947, 5774.855628609318, 5937.732802024006, 6070.423309785563, 6076.57463977535, 3981.7212795104065, 3991.6207960243732, 3999.700172400939, 4002.519697636302, 4045.9190816182922, 4473.507914129378, 5727.198192253171, 5852.5317974561085, 5933.656205798599, 5977.970110149421, 4999.425525643995, 5135.512126347991, 5675.077335172472, 5726.112452569859, 5743.59794814359, 4564.6576506762785, 5700.743466543932, 5747.735498190392, 5767.509761670305, 5801.346616214359, 5303.946960530346, 5396.460353964572, 5568.276124103841, 5613.915791263053, 5638.490871562116, 4971.850844474671, 5655.830325090254, 5730.023142015998, 5731.65306153062, 5757.309122905111, 5165.9483405165465, 5285.810692594136, 5608.327000759935, 5608.943910561005, 5632.057559708139], "value": 4150.1373806237725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.9132121502989, 738.7192866710649, 742.7994441500794, 785.9882101768471, 830.975070747877, 14929.850701492995, 16136.677266454693, 16158.919205403956, 16184.83815161848, 16204.432844850418, 14321.140731556088, 14647.194404307758, 14831.77752333716, 14840.332185051699, 14872.256387180625, 864.7967727584013, 866.7833041739565, 866.9783255418602, 867.839449701804, 868.5006121480143, 863.4991704811226, 880.8150288439404, 882.8719835623831, 885.1016218538189, 885.1325700813175, 924.9537523123851, 925.1349987761431, 927.5964955244457, 927.8329900617886, 928.4893308680199, 916.4867674102524, 919.2921450483124, 919.462114662923, 920.0385597051097, 921.3918813583003, 679.2155060904663, 680.7787469072522, 680.8536164724608, 681.5297444763098, 681.6046692918145, 13029.153105048237, 13455.058145929788, 13455.730885382238, 13490.93254533731, 13506.122102063433, 12151.696207594792, 12183.756324873542, 12414.503419863195, 12418.627441176688, 12503.187292826027, 10988.230823842334, 11104.666859994133, 11151.944240278828, 11163.83254251187, 11529.711757206136, 3802.5627052888995, 3822.2164456286396, 3891.066144125418, 3953.6441720245316, 3965.524137103566, 66577.66711166414, 104075.0, 104096.0, 105448.0, 120648.0, 11648.94175529117, 11803.763924721628, 11843.763124737457, 12008.939955300342, 12049.759004819854, 23704.64443033356, 23886.044558217476, 23898.88050559736, 23906.760932390454, 24119.75880241175, 8441.366897482714, 8457.746267611981, 8506.0, 8516.190961858614, 8525.744227673056, 4540.88647783808, 4544.840930567414, 4611.446626404786, 4632.745199014019, 4754.334393184957, 3567.0369000369756, 3683.1528748388023, 3686.225892562592, 3688.428293614494, 3697.4084146536425, 587.5446528940021, 692.7436848366136, 701.8385771272635, 703.8944158376285, 705.0657878311258, 523.7747768459599, 577.2639884147661, 615.5875563372551, 624.8125562331282, 698.6087790837147, 7682.500637458547, 9536.141747242782, 9571.952140239255, 9652.131308182157, 9746.269029822792, 599.307799491588, 632.253940350391, 670.2827974067701, 690.147667630476, 715.5420530860254, 4555.0, 4576.153411618861, 4688.367070445446, 4693.55411235932, 4696.506866778939, 137602.0, 138784.0, 143999.5600043986, 148087.51912480954, 149626.0, 83252.79469894267, 108654.45672771585, 111513.0, 112915.435422824, 119595.24654664651, 87342.0, 100964.0, 101798.0, 102922.48538757408, 104486.47756761167, 9747.0, 9945.0, 9981.950090249502, 10003.099721025143, 10033.749156271151, 54167.0, 58418.4158158413, 59092.0, 60587.0, 60913.69543152256, 72617.6369118151, 83956.0, 85212.57393712991, 86242.0, 86746.0, 12899.355032248537, 13043.478260869459, 13237.47050118023, 13343.532976345781, 13702.957627499713, 14418.567442976728, 14699.632509187355, 14753.535665073288, 14948.925255374088, 15139.318730657367, 13597.04820662544, 13620.38708258111, 13771.517996870061, 13821.101628394123, 13870.72258554803, 11817.940910295738, 13514.72970540564, 13946.093503922213, 13981.860181398055, 14014.78977815354, 13346.265955372548, 13347.86652133505, 13605.0, 14090.0, 14446.566603001927, 9375.812483750151, 11359.148063895405, 11436.085113191091, 11840.76318473643, 11894.940525297317, 11296.378699171295, 11390.487428065922, 11411.315321080761, 11597.76804463923, 11603.013743831869], "value": 7792.766886111173, "unit": "score"}], "name": "dromaeo_css", "value": 7253.844521749031, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 114.0, 114.0, 160.0, 155.0, 113.0, 112.0, 112.0, 114.0], "value": 120.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 106.0, 161.0, 130.0, 132.0, 131.0, 109.0, 163.0, 105.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 205.0, 258.0, 182.0, 184.0, 202.0, 243.0, 183.0, 184.0], "value": 201.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 58.0, 88.0, 60.0, 58.0, 61.0, 66.0, 84.0, 57.0], "value": 68.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 93.0, 71.0, 73.0, 67.0, 114.0, 96.0, 93.0, 117.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 90.0, 88.0, 94.0, 88.0, 91.0, 88.0, 93.0, 86.0], "value": 89.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 104.0, 141.0, 120.0, 96.0, 96.0, 96.0, 95.0], "value": 103.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 83.0, 84.0, 85.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 69.0, 77.0, 74.0, 73.0, 70.0, 69.0, 70.0, 70.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 82.0, 85.0, 82.0, 87.0, 90.0, 97.0, 70.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 139.0, 138.0, 138.0, 153.0, 153.0, 147.0, 135.0, 226.0, 163.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 164.0, 161.0, 163.0, 161.0, 163.0, 163.0, 160.0, 166.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 67.0, 67.0, 63.0, 66.0, 81.0, 80.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1481.7, "alertThreshold": 2.0}]} 05:51:23 INFO - Return code: 0 05:51:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:51:23 INFO - # TBPL SUCCESS # 05:51:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:51:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:51:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:51:23 INFO - 2016-07-02 05:51:23.343 screenresolution[2026:281687] starting screenresolution argv=screenresolution get 05:51:23 INFO - 2016-07-02 05:51:23.346 screenresolution[2026:281687] Display 0: 1600x1200x32@60 05:51:23 INFO - 2016-07-02 05:51:23.351 screenresolution[2027:281690] starting screenresolution argv=screenresolution list 05:51:23 INFO - Available Modes on Display 0 05:51:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:51:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:51:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:51:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:51:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:51:23 INFO - Intel Iris: 05:51:23 INFO - Chipset Model: Intel Iris 05:51:23 INFO - Type: GPU 05:51:23 INFO - Bus: Built-In 05:51:23 INFO - VRAM (Dynamic, Max): 1536 MB 05:51:23 INFO - Vendor: Intel (0x8086) 05:51:23 INFO - Device ID: 0x0a2e 05:51:23 INFO - Revision ID: 0x0009 05:51:23 INFO - Displays: 05:51:23 INFO - Display: 05:51:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:51:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:51:23 INFO - Display Serial Number: 1600x1200 60 05:51:23 INFO - Main Display: Yes 05:51:23 INFO - Mirror: Off 05:51:23 INFO - Online: Yes 05:51:23 INFO - Rotation: Supported 05:51:23 INFO - Return code: 0 05:51:23 INFO - Running post-action listener: _resource_record_post_action 05:51:23 INFO - ##### 05:51:23 INFO - ##### Finished run-tests step (success) 05:51:23 INFO - ##### 05:51:23 INFO - Running post-run listener: _resource_record_post_run 05:51:23 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 1564160; Write bytes: 708125696; Read time: 19; Write time: 2045 05:51:23 INFO - TinderboxPrint: CPU usage
53.6% 05:51:23 INFO - TinderboxPrint: I/O read bytes / time
1,564,160 / 19 05:51:23 INFO - TinderboxPrint: I/O write bytes / time
708,125,696 / 2,045 05:51:23 INFO - TinderboxPrint: CPU idle
2,248.2 (46.4%) 05:51:23 INFO - TinderboxPrint: CPU system
972.7 (20.1%) 05:51:23 INFO - TinderboxPrint: CPU user
1,628.7 (33.6%) 05:51:23 INFO - TinderboxPrint: Swap in / out
423,972,864 / 0 05:51:23 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 404595200; Write bytes: 396937216; Read time: 30540; Write time: 851 05:51:23 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1486336; Write bytes: 297356288; Read time: 18; Write time: 1152 05:51:24 INFO - Running post-run listener: _upload_blobber_files 05:51:24 INFO - Blob upload gear active. 05:51:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:51:24 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 05:51:24 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'] 05:51:24 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 05:51:24 INFO - (blobuploader) - INFO - Open directory for files ... 05:51:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:51:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:51:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:25 INFO - (blobuploader) - INFO - Done attempting. 05:51:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:51:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:51:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:26 INFO - (blobuploader) - INFO - Done attempting. 05:51:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:51:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:51:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:28 INFO - (blobuploader) - INFO - Done attempting. 05:51:28 INFO - (blobuploader) - INFO - Iteration through files over. 05:51:28 INFO - Return code: 0 05:51:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:51:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:51:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/042e7e826ae76cf446d3dbc2d88d77f8b61f2f633e4aee9af15bdfd58f01e0684fcd1dd85e4686d237dcb460cfbc45ef9f0dced6ab6bcf80462ee9d5c961d234", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cd99cbd56c6e8b0c53544537fc91987f47255158f0800811bcf7cc239bb6f271aecc60ad95fbabe010dfef8ec8c0d237928d1f0f4af959fb6801a32ed5adb94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8f106401768854eeee06ed2b7050fd8aef86d9e0eb38b1a39d0be49f12beadea19bcea688b08bd4a52e2284aadc3e2d90df2b02405b8cb22eb8656efa3ec192"} 05:51:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:51:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:51:28 INFO - Contents: 05:51:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/042e7e826ae76cf446d3dbc2d88d77f8b61f2f633e4aee9af15bdfd58f01e0684fcd1dd85e4686d237dcb460cfbc45ef9f0dced6ab6bcf80462ee9d5c961d234", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cd99cbd56c6e8b0c53544537fc91987f47255158f0800811bcf7cc239bb6f271aecc60ad95fbabe010dfef8ec8c0d237928d1f0f4af959fb6801a32ed5adb94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8f106401768854eeee06ed2b7050fd8aef86d9e0eb38b1a39d0be49f12beadea19bcea688b08bd4a52e2284aadc3e2d90df2b02405b8cb22eb8656efa3ec192"} 05:51:28 INFO - Running post-run listener: copy_logs_to_upload_dir 05:51:28 INFO - Copying logs to upload dir... 05:51:28 INFO - mkdir: /builds/slave/test/build/upload/logs 05:51:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1326.748764 ========= master_lag: 0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 7 secs) (at 2016-07-02 05:51:29.268728) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 05:51:29.269791) ========= 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.gXG28HrwsX/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.iEzRDHzMUT/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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/042e7e826ae76cf446d3dbc2d88d77f8b61f2f633e4aee9af15bdfd58f01e0684fcd1dd85e4686d237dcb460cfbc45ef9f0dced6ab6bcf80462ee9d5c961d234", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cd99cbd56c6e8b0c53544537fc91987f47255158f0800811bcf7cc239bb6f271aecc60ad95fbabe010dfef8ec8c0d237928d1f0f4af959fb6801a32ed5adb94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8f106401768854eeee06ed2b7050fd8aef86d9e0eb38b1a39d0be49f12beadea19bcea688b08bd4a52e2284aadc3e2d90df2b02405b8cb22eb8656efa3ec192"} build_url:https://queue.taskcluster.net/v1/task/LXBSOjAuT9GDcyHm1KxAdw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010992 build_url: 'https://queue.taskcluster.net/v1/task/LXBSOjAuT9GDcyHm1KxAdw/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/042e7e826ae76cf446d3dbc2d88d77f8b61f2f633e4aee9af15bdfd58f01e0684fcd1dd85e4686d237dcb460cfbc45ef9f0dced6ab6bcf80462ee9d5c961d234", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cd99cbd56c6e8b0c53544537fc91987f47255158f0800811bcf7cc239bb6f271aecc60ad95fbabe010dfef8ec8c0d237928d1f0f4af959fb6801a32ed5adb94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8f106401768854eeee06ed2b7050fd8aef86d9e0eb38b1a39d0be49f12beadea19bcea688b08bd4a52e2284aadc3e2d90df2b02405b8cb22eb8656efa3ec192"}' ========= master_lag: 0.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 05:51:29.664885) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 05:51:29.665618) ========= 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.gXG28HrwsX/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.iEzRDHzMUT/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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.005179 ========= master_lag: 1.76 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 05:51:31.435140) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 05:51:31.435473) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 05:51:31.436302) ========= ========= Total master_lag: 2.59 =========